[INFO] cloning repository https://github.com/draffle-io/draffle [INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/draffle-io/draffle" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fdraffle-io%2Fdraffle", kill_on_drop: false }` [INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fdraffle-io%2Fdraffle'... [INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }` [INFO] [stdout] d2548ba330553eb9c870a3043c0b43fbe915e6a0 [INFO] testing draffle-io/draffle against try#8262275854dc0e5381c9d42d56257d94932c5a87 for pr-90799 [INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fdraffle-io%2Fdraffle" "/workspace/builds/worker-0/source", kill_on_drop: false }` [INFO] [stderr] Cloning into '/workspace/builds/worker-0/source'... [INFO] [stderr] done. [INFO] validating manifest of git repo https://github.com/draffle-io/draffle 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/draffle-io/draffle [INFO] finished tweaking git repo https://github.com/draffle-io/draffle [INFO] tweaked toml for git repo https://github.com/draffle-io/draffle written to /workspace/builds/worker-0/source/Cargo.toml [INFO] crate git repo https://github.com/draffle-io/draffle 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 zeroize_derive v1.2.0 [INFO] [stderr] Downloaded solana-config-program v1.7.11 [INFO] [stderr] Downloaded ouroboros_macro v0.10.1 [INFO] [stderr] Downloaded educe v0.4.18 [INFO] [stderr] Downloaded solana-banks-client v1.7.11 [INFO] [stderr] Downloaded solana-crate-features v1.7.11 [INFO] [stderr] Downloaded solana-stake-program v1.7.11 [INFO] [stderr] Downloaded ouroboros v0.10.1 [INFO] [stderr] Downloaded solana-measure v1.7.11 [INFO] [stderr] Downloaded solana_rbpf v0.2.11 [INFO] [stderr] Downloaded chrono-humanize v0.2.1 [INFO] [stderr] Downloaded solana-banks-server v1.7.11 [INFO] [stderr] Downloaded num-bigint v0.4.2 [INFO] [stderr] Downloaded aliasable v0.1.3 [INFO] [stderr] Downloaded solana-rayon-threadlimit v1.7.11 [INFO] [stderr] Downloaded solana-secp256k1-program v1.7.11 [INFO] [stderr] Downloaded solana-runtime v1.7.11 [INFO] [stderr] Downloaded solana-metrics v1.7.11 [INFO] [stderr] Downloaded solana-vote-program v1.7.11 [INFO] [stderr] Downloaded solana-program-test v1.7.11 [INFO] [stderr] Downloaded solana-sdk v1.7.11 [INFO] [stderr] Downloaded solana-banks-interface v1.7.11 [INFO] [stderr] Downloaded solana-bpf-loader-program v1.7.11 [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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+8262275854dc0e5381c9d42d56257d94932c5a87" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 78b34a3be1ebf11976b059f99bbf801376918a11b43033457e3d60966fc8a8a4 [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" "78b34a3be1ebf11976b059f99bbf801376918a11b43033457e3d60966fc8a8a4", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "78b34a3be1ebf11976b059f99bbf801376918a11b43033457e3d60966fc8a8a4", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "78b34a3be1ebf11976b059f99bbf801376918a11b43033457e3d60966fc8a8a4", kill_on_drop: false }` [INFO] [stdout] 78b34a3be1ebf11976b059f99bbf801376918a11b43033457e3d60966fc8a8a4 [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" "-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] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap. [INFO] [stdout] 0f2824c3c01825b3bf983b77afa06af6cfb9ca01bd748298d61cc229b8cdc3fc [INFO] running `Command { std: "docker" "start" "-a" "0f2824c3c01825b3bf983b77afa06af6cfb9ca01bd748298d61cc229b8cdc3fc", kill_on_drop: false }` [INFO] [stderr] Compiling proc-macro2 v1.0.29 [INFO] [stderr] Compiling unicode-xid v0.2.2 [INFO] [stderr] Compiling syn v1.0.77 [INFO] [stderr] Compiling serde_derive v1.0.130 [INFO] [stderr] Compiling serde v1.0.130 [INFO] [stderr] Compiling version_check v0.9.3 [INFO] [stderr] Compiling typenum v1.14.0 [INFO] [stderr] Compiling cfg-if v1.0.0 [INFO] [stderr] Compiling libc v0.2.103 [INFO] [stderr] Compiling block-padding v0.2.1 [INFO] [stderr] Compiling opaque-debug v0.3.0 [INFO] [stderr] Compiling cpufeatures v0.2.1 [INFO] [stderr] Compiling subtle v2.4.1 [INFO] [stderr] Compiling bs58 v0.3.1 [INFO] [stderr] Compiling semver-parser v0.7.0 [INFO] [stderr] Compiling getrandom v0.1.16 [INFO] [stderr] Compiling memchr v2.4.1 [INFO] [stderr] Compiling ryu v1.0.5 [INFO] [stderr] Compiling crunchy v0.2.2 [INFO] [stderr] Compiling autocfg v1.0.1 [INFO] [stderr] Compiling anyhow v1.0.44 [INFO] [stderr] Compiling serde_json v1.0.68 [INFO] [stderr] Compiling unicode-segmentation v1.8.0 [INFO] [stderr] Compiling yansi v0.5.0 [INFO] [stderr] Compiling itoa v0.4.8 [INFO] [stderr] Compiling log v0.4.14 [INFO] [stderr] Compiling regex-syntax v0.6.25 [INFO] [stderr] Compiling feature-probe v0.1.1 [INFO] [stderr] Compiling rustversion v1.0.5 [INFO] [stderr] Compiling spin v0.5.2 [INFO] [stderr] Compiling humantime v2.1.0 [INFO] [stderr] Compiling termcolor v1.1.2 [INFO] [stderr] Compiling ucd-trie v0.1.3 [INFO] [stderr] Compiling ppv-lite86 v0.2.10 [INFO] [stderr] Compiling arrayref v0.3.6 [INFO] [stderr] Compiling ahash v0.4.7 [INFO] [stderr] Compiling either v1.6.1 [INFO] [stderr] Compiling cfg-if v0.1.10 [INFO] [stderr] Compiling arrayvec v0.5.2 [INFO] [stderr] Compiling keccak v0.1.0 [INFO] [stderr] Compiling byteorder v1.4.3 [INFO] [stderr] Compiling constant_time_eq v0.1.5 [INFO] [stderr] Compiling base64 v0.12.3 [INFO] [stderr] Compiling hex v0.4.3 [INFO] [stderr] Compiling bytemuck v1.7.2 [INFO] [stderr] Compiling bs58 v0.4.0 [INFO] [stderr] Compiling alloc-traits v0.1.1 [INFO] [stderr] Compiling base64 v0.13.0 [INFO] [stderr] Compiling static_assertions v1.1.0 [INFO] [stderr] Compiling safe-transmute v0.11.2 [INFO] [stderr] Compiling semver v0.9.0 [INFO] [stderr] Compiling generic-array v0.14.4 [INFO] [stderr] Compiling proc-macro2-diagnostics v0.9.1 [INFO] [stderr] Compiling lazy_static v1.4.0 [INFO] [stderr] Compiling heck v0.3.3 [INFO] [stderr] Compiling itertools v0.9.0 [INFO] [stderr] Compiling pest v2.1.3 [INFO] [stderr] Compiling bv v0.11.1 [INFO] [stderr] Compiling num-traits v0.2.14 [INFO] [stderr] Compiling memoffset v0.6.4 [INFO] [stderr] Compiling hashbrown v0.9.1 [INFO] [stderr] Compiling without-alloc v0.2.1 [INFO] [stderr] Compiling rustc_version v0.2.3 [INFO] [stderr] Compiling solana-frozen-abi-macro v1.7.11 [INFO] [stderr] Compiling solana-frozen-abi v1.7.11 [INFO] [stderr] Compiling solana-program v1.7.11 [INFO] [stderr] Compiling aho-corasick v0.7.18 [INFO] [stderr] Compiling quote v1.0.9 [INFO] [stderr] Compiling generic-array v0.12.4 [INFO] [stderr] Compiling semver-parser v0.10.2 [INFO] [stderr] Compiling digest v0.8.1 [INFO] [stderr] Compiling regex v1.5.4 [INFO] [stderr] Compiling semver v0.11.0 [INFO] [stderr] Compiling rustc_version v0.3.3 [INFO] [stderr] Compiling jobserver v0.1.24 [INFO] [stderr] Compiling atty v0.2.14 [INFO] [stderr] Compiling memmap2 v0.1.0 [INFO] [stderr] Compiling field-offset v0.3.4 [INFO] [stderr] Compiling rand_core v0.5.1 [INFO] [stderr] Compiling cc v1.0.70 [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 env_logger v0.8.4 [INFO] [stderr] Compiling solana-logger v1.7.11 [INFO] [stderr] Compiling blake3 v0.3.8 [INFO] [stderr] Compiling synstructure v0.12.5 [INFO] [stderr] Compiling borsh-schema-derive-internal v0.9.1 [INFO] [stderr] Compiling borsh-derive-internal v0.9.1 [INFO] [stderr] Compiling thiserror-impl v1.0.29 [INFO] [stderr] Compiling zeroize_derive v1.2.0 [INFO] [stderr] Compiling solana-sdk-macro v1.7.11 [INFO] [stderr] Compiling num-derive v0.3.3 [INFO] [stderr] Compiling derivative v2.2.0 [INFO] [stderr] Compiling enumflags2_derive v0.6.4 [INFO] [stderr] Compiling enumflags2 v0.6.4 [INFO] [stderr] Compiling zeroize v1.4.2 [INFO] [stderr] Compiling curve25519-dalek v2.1.3 [INFO] [stderr] Compiling thiserror v1.0.29 [INFO] [stderr] Compiling toml v0.5.8 [INFO] [stderr] Compiling bincode v1.3.3 [INFO] [stderr] Compiling serde_bytes v0.11.5 [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 sha2 v0.9.8 [INFO] [stderr] Compiling libsecp256k1-core v0.2.2 [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 proc-macro-crate v0.1.5 [INFO] [stderr] Compiling proc-macro-crate v1.1.0 [INFO] [stderr] Compiling anchor-syn v0.17.0 [INFO] [stderr] Compiling borsh-derive v0.9.1 [INFO] [stderr] Compiling num_enum_derive v0.5.4 [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.4 [INFO] [stderr] Compiling anchor-attribute-state v0.17.0 [INFO] [stderr] Compiling anchor-derive-accounts v0.17.0 [INFO] [stderr] Compiling anchor-attribute-event v0.17.0 [INFO] [stderr] Compiling anchor-attribute-error v0.17.0 [INFO] [stderr] Compiling anchor-attribute-account v0.17.0 [INFO] [stderr] Compiling anchor-attribute-access-control v0.17.0 [INFO] [stderr] Compiling anchor-attribute-program v0.17.0 [INFO] [stderr] Compiling anchor-attribute-interface v0.17.0 [INFO] [stderr] Compiling anchor-lang v0.17.0 [INFO] [stderr] Compiling spl-token v3.2.0 [INFO] [stderr] Compiling serum_dex v0.4.0 [INFO] [stderr] Compiling spl-associated-token-account v1.0.3 [INFO] [stderr] Compiling anchor-spl v0.17.0 [INFO] [stderr] Compiling draffle v0.1.0 (/opt/rustwide/workdir/programs/draffle) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 3m 14s [INFO] running `Command { std: "docker" "inspect" "0f2824c3c01825b3bf983b77afa06af6cfb9ca01bd748298d61cc229b8cdc3fc", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "0f2824c3c01825b3bf983b77afa06af6cfb9ca01bd748298d61cc229b8cdc3fc", kill_on_drop: false }` [INFO] [stdout] 0f2824c3c01825b3bf983b77afa06af6cfb9ca01bd748298d61cc229b8cdc3fc [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" "-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] 49e682a5ebe5fa372e875398ab114024f2d818698c315751045f5a10a46795aa [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" "49e682a5ebe5fa372e875398ab114024f2d818698c315751045f5a10a46795aa", kill_on_drop: false }` [INFO] [stderr] Compiling scopeguard v1.1.0 [INFO] [stderr] Compiling once_cell v1.8.0 [INFO] [stderr] Compiling futures-core v0.3.17 [INFO] [stderr] Compiling pin-project-lite v0.2.7 [INFO] [stderr] Compiling bytes v1.1.0 [INFO] [stderr] Compiling parking_lot_core v0.8.5 [INFO] [stderr] Compiling smallvec v1.7.0 [INFO] [stderr] Compiling futures-sink v0.3.17 [INFO] [stderr] Compiling proc-macro-hack v0.5.19 [INFO] [stderr] Compiling futures-task v0.3.17 [INFO] [stderr] Compiling proc-macro-nested v0.1.7 [INFO] [stderr] Compiling futures-channel v0.3.17 [INFO] [stderr] Compiling slab v0.4.4 [INFO] [stderr] Compiling fnv v1.0.7 [INFO] [stderr] Compiling untrusted v0.7.1 [INFO] [stderr] Compiling futures-io v0.3.17 [INFO] [stderr] Compiling pin-utils v0.1.0 [INFO] [stderr] Compiling adler v1.0.2 [INFO] [stderr] Compiling httparse v1.5.1 [INFO] [stderr] Compiling hashbrown v0.11.2 [INFO] [stderr] Compiling matches v0.1.9 [INFO] [stderr] Compiling gimli v0.25.0 [INFO] [stderr] Compiling percent-encoding v2.1.0 [INFO] [stderr] Compiling rustc-demangle v0.1.21 [INFO] [stderr] Compiling tinyvec_macros v0.1.0 [INFO] [stderr] Compiling try-lock v0.2.3 [INFO] [stderr] Compiling proc-macro2 v0.4.30 [INFO] [stderr] Compiling failure_derive v0.1.8 [INFO] [stderr] Compiling httpdate v1.0.1 [INFO] [stderr] Compiling unicode-xid v0.1.0 [INFO] [stderr] Compiling unicode-bidi v0.3.6 [INFO] [stderr] Compiling signature v1.3.1 [INFO] [stderr] Compiling encoding_rs v0.8.28 [INFO] [stderr] Compiling tower-service v0.3.1 [INFO] [stderr] Compiling syn v0.15.44 [INFO] [stderr] Compiling winapi v0.3.9 [INFO] [stderr] Compiling mime v0.3.16 [INFO] [stderr] Compiling ipnet v2.3.1 [INFO] [stderr] Compiling assert_matches v1.5.0 [INFO] [stderr] Compiling crossbeam-utils v0.8.5 [INFO] [stderr] Compiling crossbeam-epoch v0.9.5 [INFO] [stderr] Compiling glob v0.3.0 [INFO] [stderr] Compiling rayon-core v1.9.1 [INFO] [stderr] Compiling pkg-config v0.3.20 [INFO] [stderr] Compiling crc32fast v1.2.1 [INFO] [stderr] Compiling maybe-uninit v2.0.0 [INFO] [stderr] Compiling zstd-safe v2.0.6+zstd.1.4.7 [INFO] [stderr] Compiling same-file v1.0.6 [INFO] [stderr] Compiling Inflector v0.11.4 [INFO] [stderr] Compiling stable_deref_trait v1.2.0 [INFO] [stderr] Compiling remove_dir_all v0.5.3 [INFO] [stderr] Compiling void v1.0.2 [INFO] [stderr] Compiling aliasable v0.1.3 [INFO] [stderr] Compiling symlink v0.1.0 [INFO] [stderr] Compiling ascii v0.9.3 [INFO] [stderr] Compiling plain v0.2.3 [INFO] [stderr] Compiling async-trait v0.1.51 [INFO] [stderr] Compiling instant v0.1.11 [INFO] [stderr] Compiling futures-macro v0.3.17 [INFO] [stderr] Compiling tokio v1.12.0 [INFO] [stderr] Compiling futures-util v0.3.17 [INFO] [stderr] Compiling num-integer v0.1.44 [INFO] [stderr] Compiling miniz_oxide v0.4.4 [INFO] [stderr] Compiling indexmap v1.7.0 [INFO] [stderr] Compiling num-bigint v0.4.2 [INFO] [stderr] Compiling proc-macro-error-attr v1.0.4 [INFO] [stderr] Compiling proc-macro-error v1.0.4 [INFO] [stderr] Compiling crossbeam-utils v0.7.2 [INFO] [stderr] Compiling rayon v1.5.1 [INFO] [stderr] Compiling libloading v0.6.7 [INFO] [stderr] Compiling hash32 v0.1.1 [INFO] [stderr] Compiling lock_api v0.4.5 [INFO] [stderr] Compiling tinyvec v1.5.0 [INFO] [stderr] Compiling form_urlencoded v1.0.1 [INFO] [stderr] Compiling qstring v0.7.2 [INFO] [stderr] Compiling http v0.2.5 [INFO] [stderr] Compiling walkdir v2.3.2 [INFO] [stderr] Compiling unreachable v1.0.0 [INFO] [stderr] Compiling tracing-core v0.1.20 [INFO] [stderr] Compiling uriparse v0.6.3 [INFO] [stderr] Compiling num_cpus v1.13.0 [INFO] [stderr] Compiling signal-hook-registry v1.4.0 [INFO] [stderr] Compiling getrandom v0.2.3 [INFO] [stderr] Compiling socket2 v0.4.2 [INFO] [stderr] Compiling time v0.1.44 [INFO] [stderr] Compiling iovec v0.1.4 [INFO] [stderr] Compiling gethostname v0.2.1 [INFO] [stderr] Compiling xattr v0.2.2 [INFO] [stderr] Compiling filetime v0.2.15 [INFO] [stderr] Compiling object v0.26.2 [INFO] [stderr] Compiling mio v0.7.13 [INFO] [stderr] Compiling want v0.3.0 [INFO] [stderr] Compiling solana-sdk v1.7.11 [INFO] [stderr] Compiling solana-vote-program v1.7.11 [INFO] [stderr] Compiling solana-stake-program v1.7.11 [INFO] [stderr] Compiling solana-runtime v1.7.11 [INFO] [stderr] Compiling combine v3.8.1 [INFO] [stderr] Compiling dir-diff v0.3.2 [INFO] [stderr] Compiling solana-rayon-threadlimit v1.7.11 [INFO] [stderr] Compiling tracing v0.1.28 [INFO] [stderr] Compiling crossbeam-channel v0.5.1 [INFO] [stderr] Compiling rand_core v0.6.3 [INFO] [stderr] Compiling parking_lot v0.11.2 [INFO] [stderr] Compiling bytes v0.4.12 [INFO] [stderr] Compiling quote v0.6.13 [INFO] [stderr] Compiling tar v0.4.37 [INFO] [stderr] Compiling unicode-normalization v0.1.19 [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 ring v0.16.20 [INFO] [stderr] Compiling backtrace v0.3.61 [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 rand_chacha v0.3.1 [INFO] [stderr] Compiling crossbeam-channel v0.4.4 [INFO] [stderr] Compiling flate2 v1.0.22 [INFO] [stderr] Compiling addr2line v0.16.0 [INFO] [stderr] Compiling crossbeam-deque v0.8.1 [INFO] [stderr] Compiling http-body v0.4.3 [INFO] [stderr] Compiling idna v0.2.3 [INFO] [stderr] Compiling rand v0.8.4 [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 crypto-mac v0.10.1 [INFO] [stderr] Compiling crypto-mac v0.9.1 [INFO] [stderr] Compiling scroll v0.10.2 [INFO] [stderr] Compiling ouroboros_macro v0.10.1 [INFO] [stderr] Compiling url v2.2.2 [INFO] [stderr] Compiling tempfile v3.2.0 [INFO] [stderr] Compiling curve25519-dalek v3.2.0 [INFO] [stderr] Compiling hmac v0.10.1 [INFO] [stderr] Compiling pbkdf2 v0.6.0 [INFO] [stderr] Compiling hmac v0.9.0 [INFO] [stderr] Compiling chrono-humanize v0.2.1 [INFO] [stderr] Compiling goblin v0.3.4 [INFO] [stderr] Compiling pin-project v1.0.8 [INFO] [stderr] Compiling failure v0.1.8 [INFO] [stderr] Compiling enum-ordinalize v3.1.10 [INFO] [stderr] Compiling derivation-path v0.1.3 [INFO] [stderr] Compiling bzip2 v0.3.3 [INFO] [stderr] Compiling ed25519-dalek v1.0.1 [INFO] [stderr] Compiling ed25519-dalek-bip32 v0.1.1 [INFO] [stderr] Compiling webpki v0.21.4 [INFO] [stderr] Compiling sct v0.6.1 [INFO] [stderr] Compiling educe v0.4.18 [INFO] [stderr] Compiling rustls v0.19.1 [INFO] [stderr] Compiling webpki-roots v0.21.1 [INFO] [stderr] Compiling ouroboros v0.10.1 [INFO] [stderr] Compiling dashmap v4.0.2 [INFO] [stderr] Compiling futures-executor v0.3.17 [INFO] [stderr] Compiling futures v0.3.17 [INFO] [stderr] Compiling tokio-util v0.6.8 [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.4 [INFO] [stderr] Compiling tarpc v0.24.1 [INFO] [stderr] Compiling solana_rbpf v0.2.11 [INFO] [stderr] Compiling hyper v0.14.13 [INFO] [stderr] Compiling hyper-rustls v0.22.1 [INFO] [stderr] Compiling reqwest v0.11.4 [INFO] [stderr] Compiling solana-crate-features v1.7.11 [INFO] [stderr] Compiling solana-metrics v1.7.11 [INFO] [stderr] Compiling solana-config-program v1.7.11 [INFO] [stderr] Compiling solana-secp256k1-program v1.7.11 [INFO] [stderr] Compiling solana-banks-interface v1.7.11 [INFO] [stderr] Compiling solana-measure v1.7.11 [INFO] [stderr] Compiling solana-banks-client v1.7.11 [INFO] [stderr] Compiling zstd v0.5.4+zstd.1.4.7 [INFO] [stderr] Compiling solana-banks-server v1.7.11 [INFO] [stderr] Compiling solana-bpf-loader-program v1.7.11 [INFO] [stderr] Compiling solana-program-test v1.7.11 [INFO] [stderr] Compiling draffle v0.1.0 (/opt/rustwide/workdir/programs/draffle) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 6m 11s [INFO] running `Command { std: "docker" "inspect" "49e682a5ebe5fa372e875398ab114024f2d818698c315751045f5a10a46795aa", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "49e682a5ebe5fa372e875398ab114024f2d818698c315751045f5a10a46795aa", kill_on_drop: false }` [INFO] [stdout] 49e682a5ebe5fa372e875398ab114024f2d818698c315751045f5a10a46795aa [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" "-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] [stdout] 171a8c307a129b641770c1cbaf2400a6dd318fd6c3f46e1c663b96dc193cd15c [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" "171a8c307a129b641770c1cbaf2400a6dd318fd6c3f46e1c663b96dc193cd15c", 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] [stderr] Finished test [unoptimized + debuginfo] target(s) in 1.70s [INFO] [stderr] Running unittests (/opt/rustwide/target/debug/deps/draffle-99d7cda4a7448909) [INFO] [stdout] [INFO] [stdout] running 2 tests [INFO] [stdout] test randomness_tools::test::test_bit_slicing ... ok [INFO] [stdout] test test_id ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s [INFO] [stdout] [INFO] [stderr] Running tests/functional.rs (/opt/rustwide/target/debug/deps/functional-f5cc90eea9090fc5) [INFO] [stdout] [INFO] [stderr] [2021-12-04T11:33:04.436057712Z INFO solana_program_test] "draffle" program loaded as native code [INFO] [stdout] running 1 test [INFO] [stderr] [2021-12-04T11:33:05.103038982Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [1] [INFO] [stderr] [2021-12-04T11:33:05.103152691Z TRACE solana_runtime::system_instruction_processor] process_instruction: CreateAccount { lamports: 1461600, space: 82, owner: TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA } [INFO] [stderr] [2021-12-04T11:33:05.103241597Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: 5b9hjVfXTeqnU51mmStMYjGvT5DeWopNVohCX41bBZ9Q, account: RefCell { value: Account { lamports: 999999999990000 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }, KeyedAccount { is_signer: true, is_writable: true, key: 6z9wFNGBvczVQvGyAhFmKgdqmAvoYPsMjiwb7KGTk4Mk, account: RefCell { value: Account { lamports: 0 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }] [INFO] [stderr] [2021-12-04T11:33:05.103558520Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-04T11:33:05.160477448Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA invoke [1] [INFO] [stderr] [2021-12-04T11:33:05.164134013Z DEBUG solana_runtime::message_processor] Program log: Instruction: InitializeMint [INFO] [stderr] [2021-12-04T11:33:05.165061180Z DEBUG solana_rbpf::vm] BPF instructions executed (interp): 2252 [INFO] [stderr] [2021-12-04T11:33:05.165141986Z DEBUG solana_rbpf::vm] Max frame depth reached: 9 [INFO] [stderr] [2021-12-04T11:33:05.165265795Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA consumed 2279 of 200000 compute units [INFO] [stderr] [2021-12-04T11:33:05.165432707Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA success [INFO] [stderr] [2021-12-04T11:33:05.358758127Z DEBUG solana_runtime::message_processor] Program ATokenGPvbdGVxr1b2hvZbsiqW5xWH25efTNsLJA8knL invoke [1] [INFO] [stderr] [2021-12-04T11:33:05.364754962Z DEBUG solana_runtime::message_processor] Program log: Transfer 2039280 lamports to the associated token account [INFO] [stderr] [2021-12-04T11:33:05.365943349Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [2] [INFO] [stderr] [2021-12-04T11:33:05.366012354Z TRACE solana_runtime::system_instruction_processor] process_instruction: Transfer { lamports: 2039280 } [INFO] [stderr] [2021-12-04T11:33:05.366037255Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: 5b9hjVfXTeqnU51mmStMYjGvT5DeWopNVohCX41bBZ9Q, account: RefCell { value: Account { lamports: 999999998523400 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }, KeyedAccount { is_signer: false, is_writable: true, key: AjHwaAowg7K4J8otyBniHiDsaU1Vtj7D83kxDTXuzyXf, account: RefCell { value: Account { lamports: 0 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }] [INFO] [stderr] [2021-12-04T11:33:05.366287473Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-04T11:33:05.366554293Z DEBUG solana_runtime::message_processor] Program log: Allocate space for the associated token account [INFO] [stderr] [2021-12-04T11:33:05.367559966Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [2] [INFO] [stderr] [2021-12-04T11:33:05.367603669Z TRACE solana_runtime::system_instruction_processor] process_instruction: Allocate { space: 165 } [INFO] [stderr] [2021-12-04T11:33:05.367623470Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: AjHwaAowg7K4J8otyBniHiDsaU1Vtj7D83kxDTXuzyXf, account: RefCell { value: Account { lamports: 2039280 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }] [INFO] [stderr] [2021-12-04T11:33:05.367984097Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-04T11:33:05.368209713Z DEBUG solana_runtime::message_processor] Program log: Assign the associated token account to the SPL Token program [INFO] [stderr] [2021-12-04T11:33:05.370895208Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [2] [INFO] [stderr] [2021-12-04T11:33:05.370954812Z TRACE solana_runtime::system_instruction_processor] process_instruction: Assign { owner: TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA } [INFO] [stderr] [2021-12-04T11:33:05.371025417Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: AjHwaAowg7K4J8otyBniHiDsaU1Vtj7D83kxDTXuzyXf, account: RefCell { value: Account { lamports: 2039280 data.len: 165 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 data: 00000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000 } } }] [INFO] [stderr] [2021-12-04T11:33:05.371209130Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-04T11:33:05.371424946Z DEBUG solana_runtime::message_processor] Program log: Initialize the associated token account [INFO] [stderr] [2021-12-04T11:33:05.392732091Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA invoke [2] [INFO] [stderr] [2021-12-04T11:33:05.393626156Z DEBUG solana_runtime::message_processor] Program log: Instruction: InitializeAccount [INFO] [stderr] [2021-12-04T11:33:05.394857145Z DEBUG solana_rbpf::vm] BPF instructions executed (interp): 3382 [INFO] [stderr] [2021-12-04T11:33:05.394886848Z DEBUG solana_rbpf::vm] Max frame depth reached: 9 [INFO] [stderr] [2021-12-04T11:33:05.394990255Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA consumed 3412 of 182974 compute units [INFO] [stderr] [2021-12-04T11:33:05.395137266Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA success [INFO] [stderr] [2021-12-04T11:33:05.400244836Z DEBUG solana_rbpf::vm] BPF instructions executed (interp): 11983 [INFO] [stderr] [2021-12-04T11:33:05.400549558Z DEBUG solana_rbpf::vm] Max frame depth reached: 10 [INFO] [stderr] [2021-12-04T11:33:05.401011692Z DEBUG solana_runtime::message_processor] Program ATokenGPvbdGVxr1b2hvZbsiqW5xWH25efTNsLJA8knL consumed 21098 of 200000 compute units [INFO] [stderr] [2021-12-04T11:33:05.401262910Z DEBUG solana_runtime::message_processor] Program ATokenGPvbdGVxr1b2hvZbsiqW5xWH25efTNsLJA8knL success [INFO] [stderr] [2021-12-04T11:33:05.508696101Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [1] [INFO] [stderr] [2021-12-04T11:33:05.508790708Z TRACE solana_runtime::system_instruction_processor] process_instruction: CreateAccount { lamports: 1461600, space: 82, owner: TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA } [INFO] [stderr] [2021-12-04T11:33:05.508878014Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: 5b9hjVfXTeqnU51mmStMYjGvT5DeWopNVohCX41bBZ9Q, account: RefCell { value: Account { lamports: 999999996474120 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }, KeyedAccount { is_signer: true, is_writable: true, key: HoNrapspasHnJQsyBuxun3cpoWdgKRxr45xronJ5rux9, account: RefCell { value: Account { lamports: 0 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }] [INFO] [stderr] [2021-12-04T11:33:05.509166235Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-04T11:33:05.524932079Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA invoke [1] [INFO] [stderr] [2021-12-04T11:33:05.525654531Z DEBUG solana_runtime::message_processor] Program log: Instruction: InitializeMint [INFO] [stderr] [2021-12-04T11:33:05.526489191Z DEBUG solana_rbpf::vm] BPF instructions executed (interp): 2252 [INFO] [stderr] [2021-12-04T11:33:05.526508693Z DEBUG solana_rbpf::vm] Max frame depth reached: 9 [INFO] [stderr] [2021-12-04T11:33:05.526591999Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA consumed 2279 of 200000 compute units [INFO] [stderr] [2021-12-04T11:33:05.526738210Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA success [INFO] [stderr] [2021-12-04T11:33:05.740208591Z DEBUG solana_runtime::message_processor] Program ATokenGPvbdGVxr1b2hvZbsiqW5xWH25efTNsLJA8knL invoke [1] [INFO] [stderr] [2021-12-04T11:33:05.742447053Z DEBUG solana_runtime::message_processor] Program log: Transfer 2039280 lamports to the associated token account [INFO] [stderr] [2021-12-04T11:33:05.743791951Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [2] [INFO] [stderr] [2021-12-04T11:33:05.743856155Z TRACE solana_runtime::system_instruction_processor] process_instruction: Transfer { lamports: 2039280 } [INFO] [stderr] [2021-12-04T11:33:05.743876557Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: 5b9hjVfXTeqnU51mmStMYjGvT5DeWopNVohCX41bBZ9Q, account: RefCell { value: Account { lamports: 999999995007520 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }, KeyedAccount { is_signer: false, is_writable: true, key: 6UpA32q1qNGfTtJdYrubaZg2Gi9RwaZKRH5nYG8UmuMx, account: RefCell { value: Account { lamports: 0 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }] [INFO] [stderr] [2021-12-04T11:33:05.744128275Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-04T11:33:05.744403695Z DEBUG solana_runtime::message_processor] Program log: Allocate space for the associated token account [INFO] [stderr] [2021-12-04T11:33:05.745422769Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [2] [INFO] [stderr] [2021-12-04T11:33:05.745467072Z TRACE solana_runtime::system_instruction_processor] process_instruction: Allocate { space: 165 } [INFO] [stderr] [2021-12-04T11:33:05.745488074Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: 6UpA32q1qNGfTtJdYrubaZg2Gi9RwaZKRH5nYG8UmuMx, account: RefCell { value: Account { lamports: 2039280 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }] [INFO] [stderr] [2021-12-04T11:33:05.745652785Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-04T11:33:05.745884902Z DEBUG solana_runtime::message_processor] Program log: Assign the associated token account to the SPL Token program [INFO] [stderr] [2021-12-04T11:33:05.748549996Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [2] [INFO] [stderr] [2021-12-04T11:33:05.748622401Z TRACE solana_runtime::system_instruction_processor] process_instruction: Assign { owner: TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA } [INFO] [stderr] [2021-12-04T11:33:05.748695506Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: 6UpA32q1qNGfTtJdYrubaZg2Gi9RwaZKRH5nYG8UmuMx, account: RefCell { value: Account { lamports: 2039280 data.len: 165 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 data: 00000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000 } } }] [INFO] [stderr] [2021-12-04T11:33:05.748880320Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-04T11:33:05.749108636Z DEBUG solana_runtime::message_processor] Program log: Initialize the associated token account [INFO] [stderr] [2021-12-04T11:33:05.771729777Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA invoke [2] [INFO] [stderr] [2021-12-04T11:33:05.772400125Z DEBUG solana_runtime::message_processor] Program log: Instruction: InitializeAccount [INFO] [stderr] [2021-12-04T11:33:05.773638015Z DEBUG solana_rbpf::vm] BPF instructions executed (interp): 3382 [INFO] [stderr] [2021-12-04T11:33:05.773679618Z DEBUG solana_rbpf::vm] Max frame depth reached: 9 [INFO] [stderr] [2021-12-04T11:33:05.773770525Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA consumed 3412 of 181474 compute units [INFO] [stderr] [2021-12-04T11:33:05.773920736Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA success [INFO] [stderr] [2021-12-04T11:33:05.774636087Z DEBUG solana_rbpf::vm] BPF instructions executed (interp): 11983 [INFO] [stderr] [2021-12-04T11:33:05.774666190Z DEBUG solana_rbpf::vm] Max frame depth reached: 10 [INFO] [stderr] [2021-12-04T11:33:05.774746195Z DEBUG solana_runtime::message_processor] Program ATokenGPvbdGVxr1b2hvZbsiqW5xWH25efTNsLJA8knL consumed 22598 of 200000 compute units [INFO] [stderr] [2021-12-04T11:33:05.774899106Z DEBUG solana_runtime::message_processor] Program ATokenGPvbdGVxr1b2hvZbsiqW5xWH25efTNsLJA8knL success [INFO] [stderr] [2021-12-04T11:33:05.935156929Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA invoke [1] [INFO] [stderr] [2021-12-04T11:33:05.935855979Z DEBUG solana_runtime::message_processor] Program log: Instruction: MintTo [INFO] [stderr] [2021-12-04T11:33:05.936836050Z DEBUG solana_rbpf::vm] BPF instructions executed (interp): 2757 [INFO] [stderr] [2021-12-04T11:33:05.936872753Z DEBUG solana_rbpf::vm] Max frame depth reached: 6 [INFO] [stderr] [2021-12-04T11:33:05.936964560Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA consumed 2776 of 200000 compute units [INFO] [stderr] [2021-12-04T11:33:05.937125371Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA success [INFO] [stderr] [2021-12-04T11:33:06.123162663Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [1] [INFO] [stderr] [2021-12-04T11:33:06.123374478Z TRACE solana_runtime::system_instruction_processor] process_instruction: CreateAccount { lamports: 1461600, space: 82, owner: TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA } [INFO] [stderr] [2021-12-04T11:33:06.123518089Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: 5b9hjVfXTeqnU51mmStMYjGvT5DeWopNVohCX41bBZ9Q, account: RefCell { value: Account { lamports: 999999992953240 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }, KeyedAccount { is_signer: true, is_writable: true, key: HUxRs7KiHeb8YkWUytMSdZEkqSMTP6xvcbhUo3qtnEGr, account: RefCell { value: Account { lamports: 0 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }] [INFO] [stderr] [2021-12-04T11:33:06.123943420Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-04T11:33:06.138802197Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA invoke [1] [INFO] [stderr] [2021-12-04T11:33:06.139536650Z DEBUG solana_runtime::message_processor] Program log: Instruction: InitializeMint [INFO] [stderr] [2021-12-04T11:33:06.140660232Z DEBUG solana_rbpf::vm] BPF instructions executed (interp): 2252 [INFO] [stderr] [2021-12-04T11:33:06.140715836Z DEBUG solana_rbpf::vm] Max frame depth reached: 9 [INFO] [stderr] [2021-12-04T11:33:06.140866847Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA consumed 2279 of 200000 compute units [INFO] [stderr] [2021-12-04T11:33:06.141100464Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA success [INFO] [stderr] [2021-12-04T11:33:06.348979740Z DEBUG solana_runtime::message_processor] Program ATokenGPvbdGVxr1b2hvZbsiqW5xWH25efTNsLJA8knL invoke [1] [INFO] [stderr] [2021-12-04T11:33:06.357084927Z DEBUG solana_runtime::message_processor] Program log: Transfer 2039280 lamports to the associated token account [INFO] [stderr] [2021-12-04T11:33:06.358392322Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [2] [INFO] [stderr] [2021-12-04T11:33:06.358482629Z TRACE solana_runtime::system_instruction_processor] process_instruction: Transfer { lamports: 2039280 } [INFO] [stderr] [2021-12-04T11:33:06.358504930Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: 5b9hjVfXTeqnU51mmStMYjGvT5DeWopNVohCX41bBZ9Q, account: RefCell { value: Account { lamports: 999999991486640 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }, KeyedAccount { is_signer: false, is_writable: true, key: GwkZJk1uxPmZU9bMFkgo6nsSeaB7RCUkfXndSg3F2uwK, account: RefCell { value: Account { lamports: 0 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }] [INFO] [stderr] [2021-12-04T11:33:06.358786151Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-04T11:33:06.359082472Z DEBUG solana_runtime::message_processor] Program log: Allocate space for the associated token account [INFO] [stderr] [2021-12-04T11:33:06.360218455Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [2] [INFO] [stderr] [2021-12-04T11:33:06.360278259Z TRACE solana_runtime::system_instruction_processor] process_instruction: Allocate { space: 165 } [INFO] [stderr] [2021-12-04T11:33:06.360298060Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: GwkZJk1uxPmZU9bMFkgo6nsSeaB7RCUkfXndSg3F2uwK, account: RefCell { value: Account { lamports: 2039280 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }] [INFO] [stderr] [2021-12-04T11:33:06.360462772Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-04T11:33:06.360719991Z DEBUG solana_runtime::message_processor] Program log: Assign the associated token account to the SPL Token program [INFO] [stderr] [2021-12-04T11:33:06.365627647Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [2] [INFO] [stderr] [2021-12-04T11:33:06.365728654Z TRACE solana_runtime::system_instruction_processor] process_instruction: Assign { owner: TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA } [INFO] [stderr] [2021-12-04T11:33:06.365813260Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: GwkZJk1uxPmZU9bMFkgo6nsSeaB7RCUkfXndSg3F2uwK, account: RefCell { value: Account { lamports: 2039280 data.len: 165 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 data: 00000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000 } } }] [INFO] [stderr] [2021-12-04T11:33:06.366025576Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-04T11:33:06.366280194Z DEBUG solana_runtime::message_processor] Program log: Initialize the associated token account [INFO] [stderr] [2021-12-04T11:33:06.381527500Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA invoke [2] [INFO] [stderr] [2021-12-04T11:33:06.382178747Z DEBUG solana_runtime::message_processor] Program log: Instruction: InitializeAccount [INFO] [stderr] [2021-12-04T11:33:06.383387635Z DEBUG solana_rbpf::vm] BPF instructions executed (interp): 3382 [INFO] [stderr] [2021-12-04T11:33:06.383426438Z DEBUG solana_rbpf::vm] Max frame depth reached: 9 [INFO] [stderr] [2021-12-04T11:33:06.383520645Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA consumed 3412 of 181474 compute units [INFO] [stderr] [2021-12-04T11:33:06.392007860Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA success [INFO] [stderr] [2021-12-04T11:33:06.393013633Z DEBUG solana_rbpf::vm] BPF instructions executed (interp): 11983 [INFO] [stderr] [2021-12-04T11:33:06.393114940Z DEBUG solana_rbpf::vm] Max frame depth reached: 10 [INFO] [stderr] [2021-12-04T11:33:06.393265651Z DEBUG solana_runtime::message_processor] Program ATokenGPvbdGVxr1b2hvZbsiqW5xWH25efTNsLJA8knL consumed 22598 of 200000 compute units [INFO] [stderr] [2021-12-04T11:33:06.393523870Z DEBUG solana_runtime::message_processor] Program ATokenGPvbdGVxr1b2hvZbsiqW5xWH25efTNsLJA8knL success [INFO] [stderr] [2021-12-04T11:33:06.547808759Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA invoke [1] [INFO] [stderr] [2021-12-04T11:33:06.548404402Z DEBUG solana_runtime::message_processor] Program log: Instruction: MintTo [INFO] [stderr] [2021-12-04T11:33:06.549380273Z DEBUG solana_rbpf::vm] BPF instructions executed (interp): 2759 [INFO] [stderr] [2021-12-04T11:33:06.549415775Z DEBUG solana_rbpf::vm] Max frame depth reached: 6 [INFO] [stderr] [2021-12-04T11:33:06.549508682Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA consumed 2778 of 200000 compute units [INFO] [stderr] [2021-12-04T11:33:06.549663193Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA success [INFO] [stderr] [2021-12-04T11:33:06.755564626Z DEBUG solana_runtime::message_processor] Program ATokenGPvbdGVxr1b2hvZbsiqW5xWH25efTNsLJA8knL invoke [1] [INFO] [stderr] [2021-12-04T11:33:06.761936988Z DEBUG solana_runtime::message_processor] Program log: Transfer 2039280 lamports to the associated token account [INFO] [stderr] [2021-12-04T11:33:06.763101572Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [2] [INFO] [stderr] [2021-12-04T11:33:06.763156276Z TRACE solana_runtime::system_instruction_processor] process_instruction: Transfer { lamports: 2039280 } [INFO] [stderr] [2021-12-04T11:33:06.763177378Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: 5b9hjVfXTeqnU51mmStMYjGvT5DeWopNVohCX41bBZ9Q, account: RefCell { value: Account { lamports: 999999989437360 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }, KeyedAccount { is_signer: false, is_writable: true, key: 9PFSDpBetm9qWZ9tfP1u3RJNgzYJYJUkmzAUpRAdkmBa, account: RefCell { value: Account { lamports: 0 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }] [INFO] [stderr] [2021-12-04T11:33:06.763434196Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-04T11:33:06.766765438Z DEBUG solana_runtime::message_processor] Program log: Allocate space for the associated token account [INFO] [stderr] [2021-12-04T11:33:06.767981726Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [2] [INFO] [stderr] [2021-12-04T11:33:06.768038630Z TRACE solana_runtime::system_instruction_processor] process_instruction: Allocate { space: 165 } [INFO] [stderr] [2021-12-04T11:33:06.768059432Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: 9PFSDpBetm9qWZ9tfP1u3RJNgzYJYJUkmzAUpRAdkmBa, account: RefCell { value: Account { lamports: 2039280 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }] [INFO] [stderr] [2021-12-04T11:33:06.768229744Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-04T11:33:06.768472262Z DEBUG solana_runtime::message_processor] Program log: Assign the associated token account to the SPL Token program [INFO] [stderr] [2021-12-04T11:33:06.771046548Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [2] [INFO] [stderr] [2021-12-04T11:33:06.771107353Z TRACE solana_runtime::system_instruction_processor] process_instruction: Assign { owner: TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA } [INFO] [stderr] [2021-12-04T11:33:06.771177758Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: 9PFSDpBetm9qWZ9tfP1u3RJNgzYJYJUkmzAUpRAdkmBa, account: RefCell { value: Account { lamports: 2039280 data.len: 165 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 data: 00000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000 } } }] [INFO] [stderr] [2021-12-04T11:33:06.771368872Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-04T11:33:06.771611789Z DEBUG solana_runtime::message_processor] Program log: Initialize the associated token account [INFO] [stderr] [2021-12-04T11:33:06.791403825Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA invoke [2] [INFO] [stderr] [2021-12-04T11:33:06.792204083Z DEBUG solana_runtime::message_processor] Program log: Instruction: InitializeAccount [INFO] [stderr] [2021-12-04T11:33:06.793487576Z DEBUG solana_rbpf::vm] BPF instructions executed (interp): 3382 [INFO] [stderr] [2021-12-04T11:33:06.793521878Z DEBUG solana_rbpf::vm] Max frame depth reached: 9 [INFO] [stderr] [2021-12-04T11:33:06.793614785Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA consumed 3412 of 178371 compute units [INFO] [stderr] [2021-12-04T11:33:06.793765796Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA success [INFO] [stderr] [2021-12-04T11:33:06.794527751Z DEBUG solana_rbpf::vm] BPF instructions executed (interp): 12118 [INFO] [stderr] [2021-12-04T11:33:06.794559654Z DEBUG solana_rbpf::vm] Max frame depth reached: 10 [INFO] [stderr] [2021-12-04T11:33:06.794637959Z DEBUG solana_runtime::message_processor] Program ATokenGPvbdGVxr1b2hvZbsiqW5xWH25efTNsLJA8knL consumed 25733 of 200000 compute units [INFO] [stderr] [2021-12-04T11:33:06.794820873Z DEBUG solana_runtime::message_processor] Program ATokenGPvbdGVxr1b2hvZbsiqW5xWH25efTNsLJA8knL success [INFO] [stderr] [2021-12-04T11:33:06.953902609Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA invoke [1] [INFO] [stderr] [2021-12-04T11:33:06.954499553Z DEBUG solana_runtime::message_processor] Program log: Instruction: MintTo [INFO] [stderr] [2021-12-04T11:33:06.964130651Z DEBUG solana_rbpf::vm] BPF instructions executed (interp): 2759 [INFO] [stderr] [2021-12-04T11:33:06.964195056Z DEBUG solana_rbpf::vm] Max frame depth reached: 6 [INFO] [stderr] [2021-12-04T11:33:06.964296863Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA consumed 2778 of 200000 compute units [INFO] [stderr] [2021-12-04T11:33:06.964464775Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA success [INFO] [stderr] [2021-12-04T11:33:07.170785138Z DEBUG solana_runtime::message_processor] Program ATokenGPvbdGVxr1b2hvZbsiqW5xWH25efTNsLJA8knL invoke [1] [INFO] [stderr] [2021-12-04T11:33:07.173264918Z DEBUG solana_runtime::message_processor] Program log: Transfer 2039280 lamports to the associated token account [INFO] [stderr] [2021-12-04T11:33:07.174547211Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [2] [INFO] [stderr] [2021-12-04T11:33:07.174611516Z TRACE solana_runtime::system_instruction_processor] process_instruction: Transfer { lamports: 2039280 } [INFO] [stderr] [2021-12-04T11:33:07.174633517Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: 5b9hjVfXTeqnU51mmStMYjGvT5DeWopNVohCX41bBZ9Q, account: RefCell { value: Account { lamports: 999999987388080 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }, KeyedAccount { is_signer: false, is_writable: true, key: 7E49CogtnyDK4ZrNaf3ZUPSv5hRYXQ7qYbYjtBFYtqq5, account: RefCell { value: Account { lamports: 0 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }] [INFO] [stderr] [2021-12-04T11:33:07.174902737Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-04T11:33:07.175183157Z DEBUG solana_runtime::message_processor] Program log: Allocate space for the associated token account [INFO] [stderr] [2021-12-04T11:33:07.176596560Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [2] [INFO] [stderr] [2021-12-04T11:33:07.176648163Z TRACE solana_runtime::system_instruction_processor] process_instruction: Allocate { space: 165 } [INFO] [stderr] [2021-12-04T11:33:07.176669565Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: 7E49CogtnyDK4ZrNaf3ZUPSv5hRYXQ7qYbYjtBFYtqq5, account: RefCell { value: Account { lamports: 2039280 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }] [INFO] [stderr] [2021-12-04T11:33:07.176840177Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-04T11:33:07.177088495Z DEBUG solana_runtime::message_processor] Program log: Assign the associated token account to the SPL Token program [INFO] [stderr] [2021-12-04T11:33:07.179643680Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [2] [INFO] [stderr] [2021-12-04T11:33:07.179753188Z TRACE solana_runtime::system_instruction_processor] process_instruction: Assign { owner: TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA } [INFO] [stderr] [2021-12-04T11:33:07.179836094Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: 7E49CogtnyDK4ZrNaf3ZUPSv5hRYXQ7qYbYjtBFYtqq5, account: RefCell { value: Account { lamports: 2039280 data.len: 165 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 data: 00000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000 } } }] [INFO] [stderr] [2021-12-04T11:33:07.180028608Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-04T11:33:07.180263225Z DEBUG solana_runtime::message_processor] Program log: Initialize the associated token account [INFO] [stderr] [2021-12-04T11:33:07.203719427Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA invoke [2] [INFO] [stderr] [2021-12-04T11:33:07.204571288Z DEBUG solana_runtime::message_processor] Program log: Instruction: InitializeAccount [INFO] [stderr] [2021-12-04T11:33:07.205756474Z DEBUG solana_rbpf::vm] BPF instructions executed (interp): 3382 [INFO] [stderr] [2021-12-04T11:33:07.205781076Z DEBUG solana_rbpf::vm] Max frame depth reached: 9 [INFO] [stderr] [2021-12-04T11:33:07.205871183Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA consumed 3412 of 179871 compute units [INFO] [stderr] [2021-12-04T11:33:07.206039695Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA success [INFO] [stderr] [2021-12-04T11:33:07.206832352Z DEBUG solana_rbpf::vm] BPF instructions executed (interp): 12118 [INFO] [stderr] [2021-12-04T11:33:07.206878756Z DEBUG solana_rbpf::vm] Max frame depth reached: 10 [INFO] [stderr] [2021-12-04T11:33:07.206970362Z DEBUG solana_runtime::message_processor] Program ATokenGPvbdGVxr1b2hvZbsiqW5xWH25efTNsLJA8knL consumed 24233 of 200000 compute units [INFO] [stderr] [2021-12-04T11:33:07.207150275Z DEBUG solana_runtime::message_processor] Program ATokenGPvbdGVxr1b2hvZbsiqW5xWH25efTNsLJA8knL success [INFO] [stderr] [2021-12-04T11:33:07.368104648Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA invoke [1] [INFO] [stderr] [2021-12-04T11:33:07.368714792Z DEBUG solana_runtime::message_processor] Program log: Instruction: MintTo [INFO] [stderr] [2021-12-04T11:33:07.369683663Z DEBUG solana_rbpf::vm] BPF instructions executed (interp): 2759 [INFO] [stderr] [2021-12-04T11:33:07.369723665Z DEBUG solana_rbpf::vm] Max frame depth reached: 6 [INFO] [stderr] [2021-12-04T11:33:07.369811372Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA consumed 2778 of 200000 compute units [INFO] [stderr] [2021-12-04T11:33:07.369965483Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA success [INFO] [stderr] [2021-12-04T11:33:07.577850559Z DEBUG solana_runtime::message_processor] Program ATokenGPvbdGVxr1b2hvZbsiqW5xWH25efTNsLJA8knL invoke [1] [INFO] [stderr] [2021-12-04T11:33:07.580042918Z DEBUG solana_runtime::message_processor] Program log: Transfer 2039280 lamports to the associated token account [INFO] [stderr] [2021-12-04T11:33:07.581151699Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [2] [INFO] [stderr] [2021-12-04T11:33:07.581198102Z TRACE solana_runtime::system_instruction_processor] process_instruction: Transfer { lamports: 2039280 } [INFO] [stderr] [2021-12-04T11:33:07.581215503Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: 5b9hjVfXTeqnU51mmStMYjGvT5DeWopNVohCX41bBZ9Q, account: RefCell { value: Account { lamports: 999999985338800 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }, KeyedAccount { is_signer: false, is_writable: true, key: 8BZVWF3RH7raVqoP6t5m5HU3TwbHiwZ8B8mQEHei3vfJ, account: RefCell { value: Account { lamports: 0 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }] [INFO] [stderr] [2021-12-04T11:33:07.581445620Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-04T11:33:07.581696638Z DEBUG solana_runtime::message_processor] Program log: Allocate space for the associated token account [INFO] [stderr] [2021-12-04T11:33:07.582630806Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [2] [INFO] [stderr] [2021-12-04T11:33:07.582667708Z TRACE solana_runtime::system_instruction_processor] process_instruction: Allocate { space: 165 } [INFO] [stderr] [2021-12-04T11:33:07.582684510Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: 8BZVWF3RH7raVqoP6t5m5HU3TwbHiwZ8B8mQEHei3vfJ, account: RefCell { value: Account { lamports: 2039280 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }] [INFO] [stderr] [2021-12-04T11:33:07.582827420Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-04T11:33:07.583022834Z DEBUG solana_runtime::message_processor] Program log: Assign the associated token account to the SPL Token program [INFO] [stderr] [2021-12-04T11:33:07.585585920Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [2] [INFO] [stderr] [2021-12-04T11:33:07.585664326Z TRACE solana_runtime::system_instruction_processor] process_instruction: Assign { owner: TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA } [INFO] [stderr] [2021-12-04T11:33:07.585746232Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: 8BZVWF3RH7raVqoP6t5m5HU3TwbHiwZ8B8mQEHei3vfJ, account: RefCell { value: Account { lamports: 2039280 data.len: 165 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 data: 00000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000 } } }] [INFO] [stderr] [2021-12-04T11:33:07.585948046Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-04T11:33:07.586173763Z DEBUG solana_runtime::message_processor] Program log: Initialize the associated token account [INFO] [stderr] [2021-12-04T11:33:07.609881082Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA invoke [2] [INFO] [stderr] [2021-12-04T11:33:07.610582633Z DEBUG solana_runtime::message_processor] Program log: Instruction: InitializeAccount [INFO] [stderr] [2021-12-04T11:33:07.611915430Z DEBUG solana_rbpf::vm] BPF instructions executed (interp): 3382 [INFO] [stderr] [2021-12-04T11:33:07.611961033Z DEBUG solana_rbpf::vm] Max frame depth reached: 9 [INFO] [stderr] [2021-12-04T11:33:07.612061640Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA consumed 3412 of 179871 compute units [INFO] [stderr] [2021-12-04T11:33:07.612223752Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA success [INFO] [stderr] [2021-12-04T11:33:07.612995708Z DEBUG solana_rbpf::vm] BPF instructions executed (interp): 12118 [INFO] [stderr] [2021-12-04T11:33:07.613028510Z DEBUG solana_rbpf::vm] Max frame depth reached: 10 [INFO] [stderr] [2021-12-04T11:33:07.613109916Z DEBUG solana_runtime::message_processor] Program ATokenGPvbdGVxr1b2hvZbsiqW5xWH25efTNsLJA8knL consumed 24233 of 200000 compute units [INFO] [stderr] [2021-12-04T11:33:07.613272628Z DEBUG solana_runtime::message_processor] Program ATokenGPvbdGVxr1b2hvZbsiqW5xWH25efTNsLJA8knL success [INFO] [stderr] [2021-12-04T11:33:07.773497848Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA invoke [1] [INFO] [stderr] [2021-12-04T11:33:07.774158596Z DEBUG solana_runtime::message_processor] Program log: Instruction: MintTo [INFO] [stderr] [2021-12-04T11:33:07.775224273Z DEBUG solana_rbpf::vm] BPF instructions executed (interp): 2759 [INFO] [stderr] [2021-12-04T11:33:07.775256075Z DEBUG solana_rbpf::vm] Max frame depth reached: 6 [INFO] [stderr] [2021-12-04T11:33:07.775356683Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA consumed 2778 of 200000 compute units [INFO] [stderr] [2021-12-04T11:33:07.784099917Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA success [INFO] [stderr] [2021-12-04T11:33:07.982387197Z DEBUG solana_runtime::message_processor] Program ATokenGPvbdGVxr1b2hvZbsiqW5xWH25efTNsLJA8knL invoke [1] [INFO] [stderr] [2021-12-04T11:33:07.984842075Z DEBUG solana_runtime::message_processor] Program log: Transfer 2039280 lamports to the associated token account [INFO] [stderr] [2021-12-04T11:33:07.986026961Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [2] [INFO] [stderr] [2021-12-04T11:33:07.986077464Z TRACE solana_runtime::system_instruction_processor] process_instruction: Transfer { lamports: 2039280 } [INFO] [stderr] [2021-12-04T11:33:07.986097866Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: 5b9hjVfXTeqnU51mmStMYjGvT5DeWopNVohCX41bBZ9Q, account: RefCell { value: Account { lamports: 999999983289520 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }, KeyedAccount { is_signer: false, is_writable: true, key: C9AJUsP1PBiANtuK9yL4g2zrR8uN6hKAW28hcaubdoL7, account: RefCell { value: Account { lamports: 0 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }] [INFO] [stderr] [2021-12-04T11:33:07.986346284Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-04T11:33:07.986594302Z DEBUG solana_runtime::message_processor] Program log: Allocate space for the associated token account [INFO] [stderr] [2021-12-04T11:33:07.987508268Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [2] [INFO] [stderr] [2021-12-04T11:33:07.987550571Z TRACE solana_runtime::system_instruction_processor] process_instruction: Allocate { space: 165 } [INFO] [stderr] [2021-12-04T11:33:07.987570673Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: C9AJUsP1PBiANtuK9yL4g2zrR8uN6hKAW28hcaubdoL7, account: RefCell { value: Account { lamports: 2039280 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }] [INFO] [stderr] [2021-12-04T11:33:07.987744585Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-04T11:33:07.987954701Z DEBUG solana_runtime::message_processor] Program log: Assign the associated token account to the SPL Token program [INFO] [stderr] [2021-12-04T11:33:07.990382877Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [2] [INFO] [stderr] [2021-12-04T11:33:07.990450782Z TRACE solana_runtime::system_instruction_processor] process_instruction: Assign { owner: TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA } [INFO] [stderr] [2021-12-04T11:33:07.990524487Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: C9AJUsP1PBiANtuK9yL4g2zrR8uN6hKAW28hcaubdoL7, account: RefCell { value: Account { lamports: 2039280 data.len: 165 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 data: 00000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000 } } }] [INFO] [stderr] [2021-12-04T11:33:07.990709600Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-04T11:33:07.990917515Z DEBUG solana_runtime::message_processor] Program log: Initialize the associated token account [INFO] [stderr] [2021-12-04T11:33:08.012478179Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA invoke [2] [INFO] [stderr] [2021-12-04T11:33:08.013124426Z DEBUG solana_runtime::message_processor] Program log: Instruction: InitializeAccount [INFO] [stderr] [2021-12-04T11:33:08.014595833Z DEBUG solana_rbpf::vm] BPF instructions executed (interp): 3382 [INFO] [stderr] [2021-12-04T11:33:08.014639236Z DEBUG solana_rbpf::vm] Max frame depth reached: 9 [INFO] [stderr] [2021-12-04T11:33:08.014740543Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA consumed 3412 of 181371 compute units [INFO] [stderr] [2021-12-04T11:33:08.014901155Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA success [INFO] [stderr] [2021-12-04T11:33:08.015683711Z DEBUG solana_rbpf::vm] BPF instructions executed (interp): 12118 [INFO] [stderr] [2021-12-04T11:33:08.015719514Z DEBUG solana_rbpf::vm] Max frame depth reached: 10 [INFO] [stderr] [2021-12-04T11:33:08.015798320Z DEBUG solana_runtime::message_processor] Program ATokenGPvbdGVxr1b2hvZbsiqW5xWH25efTNsLJA8knL consumed 22733 of 200000 compute units [INFO] [stderr] [2021-12-04T11:33:08.015957531Z DEBUG solana_runtime::message_processor] Program ATokenGPvbdGVxr1b2hvZbsiqW5xWH25efTNsLJA8knL success [INFO] [stderr] [2021-12-04T11:33:08.181560341Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA invoke [1] [INFO] [stderr] [2021-12-04T11:33:08.182157684Z DEBUG solana_runtime::message_processor] Program log: Instruction: MintTo [INFO] [stderr] [2021-12-04T11:33:08.183111854Z DEBUG solana_rbpf::vm] BPF instructions executed (interp): 2759 [INFO] [stderr] [2021-12-04T11:33:08.183131055Z DEBUG solana_rbpf::vm] Max frame depth reached: 6 [INFO] [stderr] [2021-12-04T11:33:08.183210061Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA consumed 2778 of 200000 compute units [INFO] [stderr] [2021-12-04T11:33:08.183349371Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA success [INFO] [stderr] [2021-12-04T11:33:08.395642667Z DEBUG solana_runtime::message_processor] Program ATokenGPvbdGVxr1b2hvZbsiqW5xWH25efTNsLJA8knL invoke [1] [INFO] [stderr] [2021-12-04T11:33:08.397860228Z DEBUG solana_runtime::message_processor] Program log: Transfer 2039280 lamports to the associated token account [INFO] [stderr] [2021-12-04T11:33:08.398992110Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [2] [INFO] [stderr] [2021-12-04T11:33:08.399266830Z TRACE solana_runtime::system_instruction_processor] process_instruction: Transfer { lamports: 2039280 } [INFO] [stderr] [2021-12-04T11:33:08.399289631Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: 5b9hjVfXTeqnU51mmStMYjGvT5DeWopNVohCX41bBZ9Q, account: RefCell { value: Account { lamports: 999999981240240 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }, KeyedAccount { is_signer: false, is_writable: true, key: FkhULbSFhjiprNCYBWZVgxy145sS69sKC8MXBFY9fsK6, account: RefCell { value: Account { lamports: 0 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }] [INFO] [stderr] [2021-12-04T11:33:08.399549350Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-04T11:33:08.399829270Z DEBUG solana_runtime::message_processor] Program log: Allocate space for the associated token account [INFO] [stderr] [2021-12-04T11:33:08.400786540Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [2] [INFO] [stderr] [2021-12-04T11:33:08.400837744Z TRACE solana_runtime::system_instruction_processor] process_instruction: Allocate { space: 165 } [INFO] [stderr] [2021-12-04T11:33:08.400857845Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: FkhULbSFhjiprNCYBWZVgxy145sS69sKC8MXBFY9fsK6, account: RefCell { value: Account { lamports: 2039280 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }] [INFO] [stderr] [2021-12-04T11:33:08.401014756Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-04T11:33:08.401223872Z DEBUG solana_runtime::message_processor] Program log: Assign the associated token account to the SPL Token program [INFO] [stderr] [2021-12-04T11:33:08.403657948Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [2] [INFO] [stderr] [2021-12-04T11:33:08.406700969Z TRACE solana_runtime::system_instruction_processor] process_instruction: Assign { owner: TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA } [INFO] [stderr] [2021-12-04T11:33:08.406785975Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: FkhULbSFhjiprNCYBWZVgxy145sS69sKC8MXBFY9fsK6, account: RefCell { value: Account { lamports: 2039280 data.len: 165 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 data: 00000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000 } } }] [INFO] [stderr] [2021-12-04T11:33:08.406983189Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-04T11:33:08.407227807Z DEBUG solana_runtime::message_processor] Program log: Initialize the associated token account [INFO] [stderr] [2021-12-04T11:33:08.423865714Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA invoke [2] [INFO] [stderr] [2021-12-04T11:33:08.424580065Z DEBUG solana_runtime::message_processor] Program log: Instruction: InitializeAccount [INFO] [stderr] [2021-12-04T11:33:08.425906462Z DEBUG solana_rbpf::vm] BPF instructions executed (interp): 3382 [INFO] [stderr] [2021-12-04T11:33:08.425942464Z DEBUG solana_rbpf::vm] Max frame depth reached: 9 [INFO] [stderr] [2021-12-04T11:33:08.426037371Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA consumed 3412 of 181371 compute units [INFO] [stderr] [2021-12-04T11:33:08.426193282Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA success [INFO] [stderr] [2021-12-04T11:33:08.426994140Z DEBUG solana_rbpf::vm] BPF instructions executed (interp): 12118 [INFO] [stderr] [2021-12-04T11:33:08.427027943Z DEBUG solana_rbpf::vm] Max frame depth reached: 10 [INFO] [stderr] [2021-12-04T11:33:08.427113649Z DEBUG solana_runtime::message_processor] Program ATokenGPvbdGVxr1b2hvZbsiqW5xWH25efTNsLJA8knL consumed 22733 of 200000 compute units [INFO] [stderr] [2021-12-04T11:33:08.427288862Z DEBUG solana_runtime::message_processor] Program ATokenGPvbdGVxr1b2hvZbsiqW5xWH25efTNsLJA8knL success [INFO] [stderr] [2021-12-04T11:33:08.590427893Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA invoke [1] [INFO] [stderr] [2021-12-04T11:33:08.591058939Z DEBUG solana_runtime::message_processor] Program log: Instruction: MintTo [INFO] [stderr] [2021-12-04T11:33:08.592434839Z DEBUG solana_rbpf::vm] BPF instructions executed (interp): 2759 [INFO] [stderr] [2021-12-04T11:33:08.592505044Z DEBUG solana_rbpf::vm] Max frame depth reached: 6 [INFO] [stderr] [2021-12-04T11:33:08.592614752Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA consumed 2778 of 200000 compute units [INFO] [stderr] [2021-12-04T11:33:08.592767763Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA success [INFO] [stderr] [2021-12-04T11:33:08.796041004Z DEBUG solana_runtime::message_processor] Program ATokenGPvbdGVxr1b2hvZbsiqW5xWH25efTNsLJA8knL invoke [1] [INFO] [stderr] [2021-12-04T11:33:08.798177859Z DEBUG solana_runtime::message_processor] Program log: Transfer 2039280 lamports to the associated token account [INFO] [stderr] [2021-12-04T11:33:08.799297241Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [2] [INFO] [stderr] [2021-12-04T11:33:08.799345844Z TRACE solana_runtime::system_instruction_processor] process_instruction: Transfer { lamports: 2039280 } [INFO] [stderr] [2021-12-04T11:33:08.799366446Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: 5b9hjVfXTeqnU51mmStMYjGvT5DeWopNVohCX41bBZ9Q, account: RefCell { value: Account { lamports: 999999979190960 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }, KeyedAccount { is_signer: false, is_writable: true, key: DYPFbeohbAbBz1PYiHU9fCNQ1C18VX4z1jopZn9wBjGq, account: RefCell { value: Account { lamports: 0 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }] [INFO] [stderr] [2021-12-04T11:33:08.799613364Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-04T11:33:08.800320015Z DEBUG solana_runtime::message_processor] Program log: Allocate space for the associated token account [INFO] [stderr] [2021-12-04T11:33:08.801394193Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [2] [INFO] [stderr] [2021-12-04T11:33:08.801438896Z TRACE solana_runtime::system_instruction_processor] process_instruction: Allocate { space: 165 } [INFO] [stderr] [2021-12-04T11:33:08.801461398Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: DYPFbeohbAbBz1PYiHU9fCNQ1C18VX4z1jopZn9wBjGq, account: RefCell { value: Account { lamports: 2039280 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }] [INFO] [stderr] [2021-12-04T11:33:08.801634410Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-04T11:33:08.801877428Z DEBUG solana_runtime::message_processor] Program log: Assign the associated token account to the SPL Token program [INFO] [stderr] [2021-12-04T11:33:08.804548121Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [2] [INFO] [stderr] [2021-12-04T11:33:08.804604526Z TRACE solana_runtime::system_instruction_processor] process_instruction: Assign { owner: TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA } [INFO] [stderr] [2021-12-04T11:33:08.804676631Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: DYPFbeohbAbBz1PYiHU9fCNQ1C18VX4z1jopZn9wBjGq, account: RefCell { value: Account { lamports: 2039280 data.len: 165 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 data: 00000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000 } } }] [INFO] [stderr] [2021-12-04T11:33:08.804865744Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-04T11:33:08.805076860Z DEBUG solana_runtime::message_processor] Program log: Initialize the associated token account [INFO] [stderr] [2021-12-04T11:33:08.820008343Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA invoke [2] [INFO] [stderr] [2021-12-04T11:33:08.820688092Z DEBUG solana_runtime::message_processor] Program log: Instruction: InitializeAccount [INFO] [stderr] [2021-12-04T11:33:08.821946283Z DEBUG solana_rbpf::vm] BPF instructions executed (interp): 3382 [INFO] [stderr] [2021-12-04T11:33:08.821967685Z DEBUG solana_rbpf::vm] Max frame depth reached: 9 [INFO] [stderr] [2021-12-04T11:33:08.822051591Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA consumed 3412 of 181371 compute units [INFO] [stderr] [2021-12-04T11:33:08.822196301Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA success [INFO] [stderr] [2021-12-04T11:33:08.822941755Z DEBUG solana_rbpf::vm] BPF instructions executed (interp): 12118 [INFO] [stderr] [2021-12-04T11:33:08.822966557Z DEBUG solana_rbpf::vm] Max frame depth reached: 10 [INFO] [stderr] [2021-12-04T11:33:08.823039762Z DEBUG solana_runtime::message_processor] Program ATokenGPvbdGVxr1b2hvZbsiqW5xWH25efTNsLJA8knL consumed 22733 of 200000 compute units [INFO] [stderr] [2021-12-04T11:33:08.823180973Z DEBUG solana_runtime::message_processor] Program ATokenGPvbdGVxr1b2hvZbsiqW5xWH25efTNsLJA8knL success [INFO] [stderr] [2021-12-04T11:33:09.001223485Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA invoke [1] [INFO] [stderr] [2021-12-04T11:33:09.001845630Z DEBUG solana_runtime::message_processor] Program log: Instruction: MintTo [INFO] [stderr] [2021-12-04T11:33:09.002838902Z DEBUG solana_rbpf::vm] BPF instructions executed (interp): 2759 [INFO] [stderr] [2021-12-04T11:33:09.002876105Z DEBUG solana_rbpf::vm] Max frame depth reached: 6 [INFO] [stderr] [2021-12-04T11:33:09.002970911Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA consumed 2778 of 200000 compute units [INFO] [stderr] [2021-12-04T11:33:09.003134523Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA success [INFO] [stderr] [2021-12-04T11:33:09.204709942Z DEBUG solana_runtime::message_processor] Program ATokenGPvbdGVxr1b2hvZbsiqW5xWH25efTNsLJA8knL invoke [1] [INFO] [stderr] [2021-12-04T11:33:09.206992407Z DEBUG solana_runtime::message_processor] Program log: Transfer 2039280 lamports to the associated token account [INFO] [stderr] [2021-12-04T11:33:09.210290347Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [2] [INFO] [stderr] [2021-12-04T11:33:09.210367452Z TRACE solana_runtime::system_instruction_processor] process_instruction: Transfer { lamports: 2039280 } [INFO] [stderr] [2021-12-04T11:33:09.210389054Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: 5b9hjVfXTeqnU51mmStMYjGvT5DeWopNVohCX41bBZ9Q, account: RefCell { value: Account { lamports: 999999977141680 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }, KeyedAccount { is_signer: false, is_writable: true, key: 25KBChsZPePDpLtdezBsdguuFDrLcN1mjnwkJUHeYntP, account: RefCell { value: Account { lamports: 0 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }] [INFO] [stderr] [2021-12-04T11:33:09.210641772Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-04T11:33:09.210910192Z DEBUG solana_runtime::message_processor] Program log: Allocate space for the associated token account [INFO] [stderr] [2021-12-04T11:33:09.211957468Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [2] [INFO] [stderr] [2021-12-04T11:33:09.212005971Z TRACE solana_runtime::system_instruction_processor] process_instruction: Allocate { space: 165 } [INFO] [stderr] [2021-12-04T11:33:09.212031373Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: 25KBChsZPePDpLtdezBsdguuFDrLcN1mjnwkJUHeYntP, account: RefCell { value: Account { lamports: 2039280 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }] [INFO] [stderr] [2021-12-04T11:33:09.212185584Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-04T11:33:09.212415701Z DEBUG solana_runtime::message_processor] Program log: Assign the associated token account to the SPL Token program [INFO] [stderr] [2021-12-04T11:33:09.214773972Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [2] [INFO] [stderr] [2021-12-04T11:33:09.214836376Z TRACE solana_runtime::system_instruction_processor] process_instruction: Assign { owner: TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA } [INFO] [stderr] [2021-12-04T11:33:09.214908082Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: 25KBChsZPePDpLtdezBsdguuFDrLcN1mjnwkJUHeYntP, account: RefCell { value: Account { lamports: 2039280 data.len: 165 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 data: 00000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000 } } }] [INFO] [stderr] [2021-12-04T11:33:09.215113396Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-04T11:33:09.215349214Z DEBUG solana_runtime::message_processor] Program log: Initialize the associated token account [INFO] [stderr] [2021-12-04T11:33:09.233907659Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA invoke [2] [INFO] [stderr] [2021-12-04T11:33:09.234616511Z DEBUG solana_runtime::message_processor] Program log: Instruction: InitializeAccount [INFO] [stderr] [2021-12-04T11:33:09.236082517Z DEBUG solana_rbpf::vm] BPF instructions executed (interp): 3382 [INFO] [stderr] [2021-12-04T11:33:09.236136521Z DEBUG solana_rbpf::vm] Max frame depth reached: 9 [INFO] [stderr] [2021-12-04T11:33:09.236245929Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA consumed 3412 of 179871 compute units [INFO] [stderr] [2021-12-04T11:33:09.236406741Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA success [INFO] [stderr] [2021-12-04T11:33:09.237194798Z DEBUG solana_rbpf::vm] BPF instructions executed (interp): 12118 [INFO] [stderr] [2021-12-04T11:33:09.237229600Z DEBUG solana_rbpf::vm] Max frame depth reached: 10 [INFO] [stderr] [2021-12-04T11:33:09.237315007Z DEBUG solana_runtime::message_processor] Program ATokenGPvbdGVxr1b2hvZbsiqW5xWH25efTNsLJA8knL consumed 24233 of 200000 compute units [INFO] [stderr] [2021-12-04T11:33:09.237490219Z DEBUG solana_runtime::message_processor] Program ATokenGPvbdGVxr1b2hvZbsiqW5xWH25efTNsLJA8knL success [INFO] [stderr] [2021-12-04T11:33:09.405511505Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA invoke [1] [INFO] [stderr] [2021-12-04T11:33:09.406348965Z DEBUG solana_runtime::message_processor] Program log: Instruction: MintTo [INFO] [stderr] [2021-12-04T11:33:09.407273832Z DEBUG solana_rbpf::vm] BPF instructions executed (interp): 2759 [INFO] [stderr] [2021-12-04T11:33:09.407319036Z DEBUG solana_rbpf::vm] Max frame depth reached: 6 [INFO] [stderr] [2021-12-04T11:33:09.407411542Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA consumed 2778 of 200000 compute units [INFO] [stderr] [2021-12-04T11:33:09.407580855Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA success [INFO] [stderr] [2021-12-04T11:33:09.617588285Z DEBUG solana_runtime::message_processor] Program ATokenGPvbdGVxr1b2hvZbsiqW5xWH25efTNsLJA8knL invoke [1] [INFO] [stderr] [2021-12-04T11:33:09.620053064Z DEBUG solana_runtime::message_processor] Program log: Transfer 2039280 lamports to the associated token account [INFO] [stderr] [2021-12-04T11:33:09.621322256Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [2] [INFO] [stderr] [2021-12-04T11:33:09.621387660Z TRACE solana_runtime::system_instruction_processor] process_instruction: Transfer { lamports: 2039280 } [INFO] [stderr] [2021-12-04T11:33:09.621411662Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: 5b9hjVfXTeqnU51mmStMYjGvT5DeWopNVohCX41bBZ9Q, account: RefCell { value: Account { lamports: 999999975092400 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }, KeyedAccount { is_signer: false, is_writable: true, key: Ejv5ebskX6xCpEvP3vwMz9gHVByX7QPgQF8bwEDntrtK, account: RefCell { value: Account { lamports: 0 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }] [INFO] [stderr] [2021-12-04T11:33:09.621690482Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-04T11:33:09.621997205Z DEBUG solana_runtime::message_processor] Program log: Allocate space for the associated token account [INFO] [stderr] [2021-12-04T11:33:09.623386405Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [2] [INFO] [stderr] [2021-12-04T11:33:09.623433009Z TRACE solana_runtime::system_instruction_processor] process_instruction: Allocate { space: 165 } [INFO] [stderr] [2021-12-04T11:33:09.623454310Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: Ejv5ebskX6xCpEvP3vwMz9gHVByX7QPgQF8bwEDntrtK, account: RefCell { value: Account { lamports: 2039280 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }] [INFO] [stderr] [2021-12-04T11:33:09.623633323Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-04T11:33:09.623969248Z DEBUG solana_runtime::message_processor] Program log: Assign the associated token account to the SPL Token program [INFO] [stderr] [2021-12-04T11:33:09.626639041Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [2] [INFO] [stderr] [2021-12-04T11:33:09.626703246Z TRACE solana_runtime::system_instruction_processor] process_instruction: Assign { owner: TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA } [INFO] [stderr] [2021-12-04T11:33:09.626781051Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: Ejv5ebskX6xCpEvP3vwMz9gHVByX7QPgQF8bwEDntrtK, account: RefCell { value: Account { lamports: 2039280 data.len: 165 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 data: 00000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000 } } }] [INFO] [stderr] [2021-12-04T11:33:09.626992067Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-04T11:33:09.627239885Z DEBUG solana_runtime::message_processor] Program log: Initialize the associated token account [INFO] [stderr] [2021-12-04T11:33:09.644162312Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA invoke [2] [INFO] [stderr] [2021-12-04T11:33:09.645147083Z DEBUG solana_runtime::message_processor] Program log: Instruction: InitializeAccount [INFO] [stderr] [2021-12-04T11:33:09.646554385Z DEBUG solana_rbpf::vm] BPF instructions executed (interp): 3382 [INFO] [stderr] [2021-12-04T11:33:09.646582587Z DEBUG solana_rbpf::vm] Max frame depth reached: 9 [INFO] [stderr] [2021-12-04T11:33:09.646681395Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA consumed 3412 of 181371 compute units [INFO] [stderr] [2021-12-04T11:33:09.646837506Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA success [INFO] [stderr] [2021-12-04T11:33:09.647695268Z DEBUG solana_rbpf::vm] BPF instructions executed (interp): 12118 [INFO] [stderr] [2021-12-04T11:33:09.647733071Z DEBUG solana_rbpf::vm] Max frame depth reached: 10 [INFO] [stderr] [2021-12-04T11:33:09.647837679Z DEBUG solana_runtime::message_processor] Program ATokenGPvbdGVxr1b2hvZbsiqW5xWH25efTNsLJA8knL consumed 22733 of 200000 compute units [INFO] [stderr] [2021-12-04T11:33:09.648004491Z DEBUG solana_runtime::message_processor] Program ATokenGPvbdGVxr1b2hvZbsiqW5xWH25efTNsLJA8knL success [INFO] [stderr] [2021-12-04T11:33:09.823953551Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA invoke [1] [INFO] [stderr] [2021-12-04T11:33:09.824652101Z DEBUG solana_runtime::message_processor] Program log: Instruction: MintTo [INFO] [stderr] [2021-12-04T11:33:09.825707178Z DEBUG solana_rbpf::vm] BPF instructions executed (interp): 2759 [INFO] [stderr] [2021-12-04T11:33:09.825763782Z DEBUG solana_rbpf::vm] Max frame depth reached: 6 [INFO] [stderr] [2021-12-04T11:33:09.825870190Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA consumed 2778 of 200000 compute units [INFO] [stderr] [2021-12-04T11:33:09.826044302Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA success [INFO] [stderr] [2021-12-04T11:33:10.023016287Z DEBUG solana_runtime::message_processor] Program ATokenGPvbdGVxr1b2hvZbsiqW5xWH25efTNsLJA8knL invoke [1] [INFO] [stderr] [2021-12-04T11:33:10.029467755Z DEBUG solana_runtime::message_processor] Program log: Transfer 2039280 lamports to the associated token account [INFO] [stderr] [2021-12-04T11:33:10.030646841Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [2] [INFO] [stderr] [2021-12-04T11:33:10.030715446Z TRACE solana_runtime::system_instruction_processor] process_instruction: Transfer { lamports: 2039280 } [INFO] [stderr] [2021-12-04T11:33:10.030735947Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: 5b9hjVfXTeqnU51mmStMYjGvT5DeWopNVohCX41bBZ9Q, account: RefCell { value: Account { lamports: 999999973043120 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }, KeyedAccount { is_signer: false, is_writable: true, key: 35vCGJhEsRX3f7odQjBi1DNBVfk51B1g4K43X4Ykmnv6, account: RefCell { value: Account { lamports: 0 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }] [INFO] [stderr] [2021-12-04T11:33:10.031012667Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-04T11:33:10.031297688Z DEBUG solana_runtime::message_processor] Program log: Allocate space for the associated token account [INFO] [stderr] [2021-12-04T11:33:10.032347364Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [2] [INFO] [stderr] [2021-12-04T11:33:10.032404068Z TRACE solana_runtime::system_instruction_processor] process_instruction: Allocate { space: 165 } [INFO] [stderr] [2021-12-04T11:33:10.032425170Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: 35vCGJhEsRX3f7odQjBi1DNBVfk51B1g4K43X4Ykmnv6, account: RefCell { value: Account { lamports: 2039280 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }] [INFO] [stderr] [2021-12-04T11:33:10.032583181Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-04T11:33:10.032797597Z DEBUG solana_runtime::message_processor] Program log: Assign the associated token account to the SPL Token program [INFO] [stderr] [2021-12-04T11:33:10.035182970Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [2] [INFO] [stderr] [2021-12-04T11:33:10.035264776Z TRACE solana_runtime::system_instruction_processor] process_instruction: Assign { owner: TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA } [INFO] [stderr] [2021-12-04T11:33:10.035356582Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: 35vCGJhEsRX3f7odQjBi1DNBVfk51B1g4K43X4Ykmnv6, account: RefCell { value: Account { lamports: 2039280 data.len: 165 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 data: 00000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000 } } }] [INFO] [stderr] [2021-12-04T11:33:10.035566997Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-04T11:33:10.035831017Z DEBUG solana_runtime::message_processor] Program log: Initialize the associated token account [INFO] [stderr] [2021-12-04T11:33:10.055617552Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA invoke [2] [INFO] [stderr] [2021-12-04T11:33:10.056298801Z DEBUG solana_runtime::message_processor] Program log: Instruction: InitializeAccount [INFO] [stderr] [2021-12-04T11:33:10.057504588Z DEBUG solana_rbpf::vm] BPF instructions executed (interp): 3382 [INFO] [stderr] [2021-12-04T11:33:10.057528990Z DEBUG solana_rbpf::vm] Max frame depth reached: 9 [INFO] [stderr] [2021-12-04T11:33:10.057622797Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA consumed 3412 of 182871 compute units [INFO] [stderr] [2021-12-04T11:33:10.057770908Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA success [INFO] [stderr] [2021-12-04T11:33:10.058502461Z DEBUG solana_rbpf::vm] BPF instructions executed (interp): 12118 [INFO] [stderr] [2021-12-04T11:33:10.058531763Z DEBUG solana_rbpf::vm] Max frame depth reached: 10 [INFO] [stderr] [2021-12-04T11:33:10.058605668Z DEBUG solana_runtime::message_processor] Program ATokenGPvbdGVxr1b2hvZbsiqW5xWH25efTNsLJA8knL consumed 21233 of 200000 compute units [INFO] [stderr] [2021-12-04T11:33:10.058752979Z DEBUG solana_runtime::message_processor] Program ATokenGPvbdGVxr1b2hvZbsiqW5xWH25efTNsLJA8knL success [INFO] [stderr] [2021-12-04T11:33:10.229448158Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA invoke [1] [INFO] [stderr] [2021-12-04T11:33:10.230121907Z DEBUG solana_runtime::message_processor] Program log: Instruction: MintTo [INFO] [stderr] [2021-12-04T11:33:10.231461404Z DEBUG solana_rbpf::vm] BPF instructions executed (interp): 2759 [INFO] [stderr] [2021-12-04T11:33:10.231514008Z DEBUG solana_rbpf::vm] Max frame depth reached: 6 [INFO] [stderr] [2021-12-04T11:33:10.231612615Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA consumed 2778 of 200000 compute units [INFO] [stderr] [2021-12-04T11:33:10.231827831Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA success [INFO] [stderr] [2021-12-04T11:33:10.444152829Z DEBUG solana_runtime::message_processor] Program ATokenGPvbdGVxr1b2hvZbsiqW5xWH25efTNsLJA8knL invoke [1] [INFO] [stderr] [2021-12-04T11:33:10.446260282Z DEBUG solana_runtime::message_processor] Program log: Transfer 2039280 lamports to the associated token account [INFO] [stderr] [2021-12-04T11:33:10.447472770Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [2] [INFO] [stderr] [2021-12-04T11:33:10.447542075Z TRACE solana_runtime::system_instruction_processor] process_instruction: Transfer { lamports: 2039280 } [INFO] [stderr] [2021-12-04T11:33:10.447565877Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: 5b9hjVfXTeqnU51mmStMYjGvT5DeWopNVohCX41bBZ9Q, account: RefCell { value: Account { lamports: 999999970993840 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }, KeyedAccount { is_signer: false, is_writable: true, key: 5awAoYTw4T3uRJubjSmTnCJKBaEL3KjWymi2JCUkKGxr, account: RefCell { value: Account { lamports: 0 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }] [INFO] [stderr] [2021-12-04T11:33:10.447868899Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-04T11:33:10.448158720Z DEBUG solana_runtime::message_processor] Program log: Allocate space for the associated token account [INFO] [stderr] [2021-12-04T11:33:10.449174793Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [2] [INFO] [stderr] [2021-12-04T11:33:10.449232097Z TRACE solana_runtime::system_instruction_processor] process_instruction: Allocate { space: 165 } [INFO] [stderr] [2021-12-04T11:33:10.449256999Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: 5awAoYTw4T3uRJubjSmTnCJKBaEL3KjWymi2JCUkKGxr, account: RefCell { value: Account { lamports: 2039280 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }] [INFO] [stderr] [2021-12-04T11:33:10.449433312Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-04T11:33:10.449673629Z DEBUG solana_runtime::message_processor] Program log: Assign the associated token account to the SPL Token program [INFO] [stderr] [2021-12-04T11:33:10.452069703Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [2] [INFO] [stderr] [2021-12-04T11:33:10.452133408Z TRACE solana_runtime::system_instruction_processor] process_instruction: Assign { owner: TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA } [INFO] [stderr] [2021-12-04T11:33:10.452209313Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: 5awAoYTw4T3uRJubjSmTnCJKBaEL3KjWymi2JCUkKGxr, account: RefCell { value: Account { lamports: 2039280 data.len: 165 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 data: 00000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000 } } }] [INFO] [stderr] [2021-12-04T11:33:10.452408728Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-04T11:33:10.452641045Z DEBUG solana_runtime::message_processor] Program log: Initialize the associated token account [INFO] [stderr] [2021-12-04T11:33:10.472860411Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA invoke [2] [INFO] [stderr] [2021-12-04T11:33:10.473609465Z DEBUG solana_runtime::message_processor] Program log: Instruction: InitializeAccount [INFO] [stderr] [2021-12-04T11:33:10.475002066Z DEBUG solana_rbpf::vm] BPF instructions executed (interp): 3382 [INFO] [stderr] [2021-12-04T11:33:10.475053170Z DEBUG solana_rbpf::vm] Max frame depth reached: 9 [INFO] [stderr] [2021-12-04T11:33:10.475151077Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA consumed 3412 of 182864 compute units [INFO] [stderr] [2021-12-04T11:33:10.475303388Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA success [INFO] [stderr] [2021-12-04T11:33:10.476149050Z DEBUG solana_rbpf::vm] BPF instructions executed (interp): 12125 [INFO] [stderr] [2021-12-04T11:33:10.476198453Z DEBUG solana_rbpf::vm] Max frame depth reached: 10 [INFO] [stderr] [2021-12-04T11:33:10.476287760Z DEBUG solana_runtime::message_processor] Program ATokenGPvbdGVxr1b2hvZbsiqW5xWH25efTNsLJA8knL consumed 21240 of 200000 compute units [INFO] [stderr] [2021-12-04T11:33:10.476484274Z DEBUG solana_runtime::message_processor] Program ATokenGPvbdGVxr1b2hvZbsiqW5xWH25efTNsLJA8knL success [INFO] [stderr] [2021-12-04T11:33:10.638905553Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA invoke [1] [INFO] [stderr] [2021-12-04T11:33:10.639581302Z DEBUG solana_runtime::message_processor] Program log: Instruction: MintTo [INFO] [stderr] [2021-12-04T11:33:10.640688382Z DEBUG solana_rbpf::vm] BPF instructions executed (interp): 2759 [INFO] [stderr] [2021-12-04T11:33:10.640740286Z DEBUG solana_rbpf::vm] Max frame depth reached: 6 [INFO] [stderr] [2021-12-04T11:33:10.640840793Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA consumed 2778 of 200000 compute units [INFO] [stderr] [2021-12-04T11:33:10.641011206Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA success [INFO] [stderr] [2021-12-04T11:33:10.831648431Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [1] [INFO] [stderr] [2021-12-04T11:33:10.831768040Z TRACE solana_runtime::system_instruction_processor] process_instruction: CreateAccount { lamports: 1114602240, space: 160016, owner: DJgm9u3C2eiWVeokxwzJ92GbS5j2qiqsZ16YMoe8ShXf } [INFO] [stderr] [2021-12-04T11:33:10.831853346Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: 5b9hjVfXTeqnU51mmStMYjGvT5DeWopNVohCX41bBZ9Q, account: RefCell { value: Account { lamports: 999999968939560 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }, KeyedAccount { is_signer: true, is_writable: true, key: Afk6saqwdaXqaP35Srbu5gjHCgqCcoMSVYvXovc5mANo, account: RefCell { value: Account { lamports: 0 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }] [INFO] [stderr] [2021-12-04T11:33:10.832159968Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-04T11:33:10.833025631Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [1] [INFO] [stderr] [2021-12-04T11:33:10.833351455Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [2] [INFO] [stderr] [2021-12-04T11:33:10.833423660Z TRACE solana_runtime::system_instruction_processor] process_instruction: CreateAccount { lamports: 3034560, space: 308, owner: DJgm9u3C2eiWVeokxwzJ92GbS5j2qiqsZ16YMoe8ShXf } [INFO] [stderr] [2021-12-04T11:33:10.833523767Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: 5b9hjVfXTeqnU51mmStMYjGvT5DeWopNVohCX41bBZ9Q, account: RefCell { value: Account { lamports: 999998854337320 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }, KeyedAccount { is_signer: true, is_writable: true, key: 3sPnKNrs9fxUVTDvkXCEoSZ6QP72U7ZEnkpwmLKbFpvP, account: RefCell { value: Account { lamports: 0 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }] [INFO] [stderr] [2021-12-04T11:33:10.833823189Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stdout] test test_raffle has been running for over 60 seconds [INFO] [stdout] test test_raffle ... FAILED [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- test_raffle stdout ---- [INFO] [stdout] Clock { slot: 1, epoch_start_timestamp: 1638617584, epoch: 0, leader_schedule_epoch: 1, unix_timestamp: 1638617584 } [INFO] [stdout] thread 'solana-bank-forks-client' panicked at 'Account data resizing not supported yet: 0 -> 308. Consider making this test conditional on `#[cfg(feature = "test-bpf")]`', /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/solana-program-test-1.7.11/src/lib.rs:357:25 [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x5588b9b6bf7c - 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: 0x5588b9b6bf7c - 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: 0x5588b9b6bf7c - std::sys_common::backtrace::_print_fmt::h362fa2a4f354f877 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:67:5 [INFO] [stdout] 3: 0x5588b9b6bf7c - ::fmt::hf439e5ed84c74abd [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:46:22 [INFO] [stdout] 4: 0x5588b9b9193c - core::fmt::write::h72801a82c94e6ff1 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/fmt/mod.rs:1149:17 [INFO] [stdout] 5: 0x5588b9b644a5 - std::io::Write::write_fmt::h54337adeb3504c03 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/io/mod.rs:1697:15 [INFO] [stdout] 6: 0x5588b9b6de90 - std::sys_common::backtrace::_print::hb29ddd998d02631c [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:49:5 [INFO] [stdout] 7: 0x5588b9b6de90 - std::sys_common::backtrace::print::h81965e3d7c90fbb6 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:36:9 [INFO] [stdout] 8: 0x5588b9b6de90 - std::panicking::default_hook::{{closure}}::h84db205ab6674b38 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:211:50 [INFO] [stdout] 9: 0x5588b9b6da76 - std::panicking::default_hook::h1bf8bb4159936bca [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:225:9 [INFO] [stdout] 10: 0x5588b9b6e544 - std::panicking::rust_panic_with_hook::hf8e86850fbbd03b1 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:606:17 [INFO] [stdout] 11: 0x5588b9b6e020 - std::panicking::begin_panic_handler::{{closure}}::h590a0d6060ff866e [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:502:13 [INFO] [stdout] 12: 0x5588b9b6c434 - 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: 0x5588b9b6df89 - rust_begin_unwind [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:498:5 [INFO] [stdout] 14: 0x5588b88a1f81 - core::panicking::panic_fmt::h7b8580d81fcbbacd [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/panicking.rs:106:14 [INFO] [stdout] 15: 0x5588b894241c - ::sol_invoke_signed::h5ac85d69ec332e39 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/solana-program-test-1.7.11/src/lib.rs:357:25 [INFO] [stdout] 16: 0x5588b9a0dada - solana_program::program_stubs::sol_invoke_signed::h52bacb50e41a4b03 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/solana-program-1.7.11/src/program_stubs.rs:108:5 [INFO] [stdout] 17: 0x5588b9a06c5f - solana_program::program::invoke_signed::h382921cb91e537d6 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/solana-program-1.7.11/src/program.rs:54:5 [INFO] [stdout] 18: 0x5588b99aa830 - ::try_accounts::h8b24fd9769c91a10 [INFO] [stdout] at /opt/rustwide/workdir/programs/draffle/src/lib.rs:245:10 [INFO] [stdout] 19: 0x5588b99ca465 - draffle::__private::__global::create_raffle::h6928627f2382521b [INFO] [stdout] at /opt/rustwide/workdir/programs/draffle/src/lib.rs:17:1 [INFO] [stdout] 20: 0x5588b99a8869 - draffle::dispatch::h03490213620dfdd6 [INFO] [stdout] at /opt/rustwide/workdir/programs/draffle/src/lib.rs:17:1 [INFO] [stdout] 21: 0x5588b99a81f9 - draffle::entry::h22510b67456a99a6 [INFO] [stdout] at /opt/rustwide/workdir/programs/draffle/src/lib.rs:17:1 [INFO] [stdout] 22: 0x5588b893d28e - solana_program_test::builtin_process_instruction::h1a83d99f09405ab7 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/solana-program-test-1.7.11/src/lib.rs:153:5 [INFO] [stdout] 23: 0x5588b88fb760 - functional::DraffleProgramTest::start_new::{{closure}}::{{closure}}::h8b2545ecacc8384a [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/solana-program-test-1.7.11/src/lib.rs:176:17 [INFO] [stdout] 24: 0x5588b88f05fe - core::ops::function::FnOnce::call_once::h28efeace2cef6825 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/ops/function.rs:227:5 [INFO] [stdout] 25: 0x5588b8b8c2f2 - solana_runtime::message_processor::MessageProcessor::process_instruction::h4f897259e0396e7d [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/solana-runtime-1.7.11/src/message_processor.rs:645:32 [INFO] [stdout] 26: 0x5588b8b9619c - solana_runtime::message_processor::MessageProcessor::execute_instruction::h0609e80fd2ed2ee2 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/solana-runtime-1.7.11/src/message_processor.rs:1175:9 [INFO] [stdout] 27: 0x5588b8b96c1d - solana_runtime::message_processor::MessageProcessor::process_message::h9ff136f5ece72259 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/solana-runtime-1.7.11/src/message_processor.rs:1217:13 [INFO] [stdout] 28: 0x5588b8c656f4 - solana_runtime::bank::Bank::load_and_execute_transactions::{{closure}}::h79ca00235cce0dc7 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/solana-runtime-1.7.11/src/bank.rs:3170:46 [INFO] [stdout] 29: 0x5588b8c4145a - core::ops::function::impls:: for &mut F>::call_once::ha2068cf0acd4e18f [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/ops/function.rs:280:13 [INFO] [stdout] 30: 0x5588b8bebd9d - core::option::Option::map::hb7e4833d21ef8566 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/option.rs:846:29 [INFO] [stdout] 31: 0x5588b8ccd2fe - as core::iter::traits::iterator::Iterator>::next::hfd6bb7948688049e [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/iter/adapters/map.rs:103:9 [INFO] [stdout] 32: 0x5588b8da647c - as alloc::vec::spec_from_iter_nested::SpecFromIterNested>::from_iter::hb31f1cf14dc46aeb [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/alloc/src/vec/spec_from_iter_nested.rs:23:32 [INFO] [stdout] 33: 0x5588b8dd39f0 - as alloc::vec::spec_from_iter::SpecFromIter>::from_iter::hd20d8d5bb616c2b8 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/alloc/src/vec/spec_from_iter.rs:33:9 [INFO] [stdout] 34: 0x5588b8dcca16 - as core::iter::traits::collect::FromIterator>::from_iter::h20429cc11d233c94 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/alloc/src/vec/mod.rs:2518:9 [INFO] [stdout] 35: 0x5588b8d07f40 - core::iter::traits::iterator::Iterator::collect::h8ddd032d61fa3c8d [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/iter/traits/iterator.rs:1745:9 [INFO] [stdout] 36: 0x5588b8c63245 - solana_runtime::bank::Bank::load_and_execute_transactions::h57d0e358660bfeb8 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/solana-runtime-1.7.11/src/bank.rs:3137:57 [INFO] [stdout] 37: 0x5588b8c6c05d - solana_runtime::bank::Bank::load_execute_and_commit_transactions::h6d485a619c43d2bb [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/solana-runtime-1.7.11/src/bank.rs:4062:13 [INFO] [stdout] 38: 0x5588b8c6c6cc - solana_runtime::bank::Bank::process_transaction_batch::h0c63c682bea5b8c4 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/solana-runtime-1.7.11/src/bank.rs:4109:9 [INFO] [stdout] 39: 0x5588b8c6c604 - solana_runtime::bank::Bank::process_transactions::hf06c2ce79cf41faf [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/solana-runtime-1.7.11/src/bank.rs:4104:9 [INFO] [stdout] 40: 0x5588b89d9079 - solana_banks_server::banks_server::BanksServer::run::h8ffa1b89a155739e [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/solana-banks-server-1.7.11/src/banks_server.rs:76:21 [INFO] [stdout] 41: 0x5588b89d97b4 - solana_banks_server::banks_server::BanksServer::new_loopback::{{closure}}::ha57a1198dcbd1b29 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/solana-banks-server-1.7.11/src/banks_server.rs:96:28 [INFO] [stdout] 42: 0x5588b89c4828 - std::sys_common::backtrace::__rust_begin_short_backtrace::h808e9b2cd6b8e9e8 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:123:18 [INFO] [stdout] 43: 0x5588b89e1fe6 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::hd8dfe3cf630fd3b3 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/thread/mod.rs:484:17 [INFO] [stdout] 44: 0x5588b89a8309 - as core::ops::function::FnOnce<()>>::call_once::had8baad4cd52a3b0 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/panic/unwind_safe.rs:271:9 [INFO] [stdout] 45: 0x5588b89de3aa - std::panicking::try::do_call::h39f9c3ba652dd1f5 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:406:40 [INFO] [stdout] 46: 0x5588b89e0a7b - __rust_try [INFO] [stdout] 47: 0x5588b89de11a - std::panicking::try::hfd56aef4b7314f46 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:370:19 [INFO] [stdout] 48: 0x5588b89c4909 - std::panic::catch_unwind::h15777458e7555a59 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panic.rs:133:14 [INFO] [stdout] 49: 0x5588b89e1e01 - std::thread::Builder::spawn_unchecked::{{closure}}::h8c4c0a1cffca8aad [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/thread/mod.rs:483:30 [INFO] [stdout] 50: 0x5588b89a085f - core::ops::function::FnOnce::call_once{{vtable.shim}}::h340d02e82b05207c [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/ops/function.rs:227:5 [INFO] [stdout] 51: 0x5588b9b73f53 - as core::ops::function::FnOnce>::call_once::h771719d52c343434 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/alloc/src/boxed.rs:1694:9 [INFO] [stdout] 52: 0x5588b9b73f53 - as core::ops::function::FnOnce>::call_once::hf441746dfa4b0f57 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/alloc/src/boxed.rs:1694:9 [INFO] [stdout] 53: 0x5588b9b73f53 - 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] 54: 0x7fd718a53609 - start_thread [INFO] [stdout] 55: 0x7fd718829293 - clone [INFO] [stdout] 56: 0x0 - [INFO] [stdout] thread 'test_raffle' panicked at 'assertion failed: `Err(IoError(Custom { kind: TimedOut, error: "Client dropped expired request." }))` does not match `Ok(())`', programs/draffle/tests/functional.rs:582:9 [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x5588b9b6bf7c - 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: 0x5588b9b6bf7c - 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: 0x5588b9b6bf7c - std::sys_common::backtrace::_print_fmt::h362fa2a4f354f877 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:67:5 [INFO] [stdout] 3: 0x5588b9b6bf7c - ::fmt::hf439e5ed84c74abd [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:46:22 [INFO] [stdout] 4: 0x5588b9b9193c - core::fmt::write::h72801a82c94e6ff1 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/fmt/mod.rs:1149:17 [INFO] [stdout] 5: 0x5588b9b644a5 - std::io::Write::write_fmt::h54337adeb3504c03 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/io/mod.rs:1697:15 [INFO] [stdout] 6: 0x5588b9b6de90 - std::sys_common::backtrace::_print::hb29ddd998d02631c [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:49:5 [INFO] [stdout] 7: 0x5588b9b6de90 - std::sys_common::backtrace::print::h81965e3d7c90fbb6 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:36:9 [INFO] [stdout] 8: 0x5588b9b6de90 - std::panicking::default_hook::{{closure}}::h84db205ab6674b38 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:211:50 [INFO] [stdout] 9: 0x5588b9b6da76 - std::panicking::default_hook::h1bf8bb4159936bca [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:225:9 [INFO] [stdout] 10: 0x5588b9b6e544 - std::panicking::rust_panic_with_hook::hf8e86850fbbd03b1 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:606:17 [INFO] [stdout] 11: 0x5588b9b6e020 - std::panicking::begin_panic_handler::{{closure}}::h590a0d6060ff866e [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:502:13 [INFO] [stdout] 12: 0x5588b9b6c434 - 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: 0x5588b9b6df89 - rust_begin_unwind [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:498:5 [INFO] [stdout] 14: 0x5588b88a1f81 - core::panicking::panic_fmt::h7b8580d81fcbbacd [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/panicking.rs:106:14 [INFO] [stdout] 15: 0x5588b88fc3d8 - functional::DraffleProgramTest::process_tx_and_assert_ok::{{closure}}::hd0369e7299afc9f8 [INFO] [stdout] at /opt/rustwide/workdir/programs/draffle/tests/functional.rs:582:9 [INFO] [stdout] 16: 0x5588b88dfeeb - as core::future::future::Future>::poll::h32fea6e0a4c85dfd [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/future/mod.rs:80:19 [INFO] [stdout] 17: 0x5588b88ff3bc - functional::test_raffle::{{closure}}::ha795c0b72c8ccdb6 [INFO] [stdout] at /opt/rustwide/workdir/programs/draffle/tests/functional.rs:95:5 [INFO] [stdout] 18: 0x5588b88dff7b - as core::future::future::Future>::poll::h36fd4709f4863800 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/future/mod.rs:80:19 [INFO] [stdout] 19: 0x5588b88e4b9a - as core::future::future::Future>::poll::h20e53dd8d4b722bf [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/future/future.rs:119:9 [INFO] [stdout] 20: 0x5588b88ee040 - tokio::runtime::basic_scheduler::Inner

::block_on::{{closure}}::{{closure}}::h8f7addc1b3f2c75a [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.12.0/src/runtime/basic_scheduler.rs:230:62 [INFO] [stdout] 21: 0x5588b88e75e0 - tokio::coop::with_budget::{{closure}}::h48491bca22c3be00 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.12.0/src/coop.rs:106:9 [INFO] [stdout] 22: 0x5588b88e5338 - std::thread::local::LocalKey::try_with::hb74cb61930a4e790 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/thread/local.rs:399:16 [INFO] [stdout] 23: 0x5588b88e508d - std::thread::local::LocalKey::with::hd4cc156109a87069 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/thread/local.rs:375:9 [INFO] [stdout] 24: 0x5588b88ed7c1 - tokio::coop::with_budget::hb84b5ab6adb2fb9f [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.12.0/src/coop.rs:99:5 [INFO] [stdout] 25: 0x5588b88ed7c1 - tokio::coop::budget::h176b3e9497cbbc75 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.12.0/src/coop.rs:76:5 [INFO] [stdout] 26: 0x5588b88ed7c1 - tokio::runtime::basic_scheduler::Inner

::block_on::{{closure}}::hce9ff958968df90e [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.12.0/src/runtime/basic_scheduler.rs:230:39 [INFO] [stdout] 27: 0x5588b88ee9e1 - tokio::runtime::basic_scheduler::enter::{{closure}}::h0a5aa8c957ce4612 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.12.0/src/runtime/basic_scheduler.rs:339:29 [INFO] [stdout] 28: 0x5588b88d37b7 - tokio::macros::scoped_tls::ScopedKey::set::hbbefe093f9c6a2eb [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.12.0/src/macros/scoped_tls.rs:61:9 [INFO] [stdout] 29: 0x5588b88ee96c - tokio::runtime::basic_scheduler::enter::h1bf0ccc3e13a2c2d [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.12.0/src/runtime/basic_scheduler.rs:339:5 [INFO] [stdout] 30: 0x5588b88ed45b - tokio::runtime::basic_scheduler::Inner

::block_on::h0dae2055cfbc3ad1 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.12.0/src/runtime/basic_scheduler.rs:218:9 [INFO] [stdout] 31: 0x5588b88ee1c6 - tokio::runtime::basic_scheduler::InnerGuard

::block_on::h6b7d47b4cd8cc1d2 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.12.0/src/runtime/basic_scheduler.rs:489:9 [INFO] [stdout] 32: 0x5588b88ee2d6 - tokio::runtime::basic_scheduler::BasicScheduler

::block_on::hd26eeb9c47c567de [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.12.0/src/runtime/basic_scheduler.rs:178:24 [INFO] [stdout] 33: 0x5588b88d394e - tokio::runtime::Runtime::block_on::hf4fdf655fc67ed17 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.12.0/src/runtime/mod.rs:461:46 [INFO] [stdout] 34: 0x5588b88fd08f - functional::test_raffle::hb26fcb4f212bd5ae [INFO] [stdout] at /opt/rustwide/workdir/programs/draffle/tests/functional.rs:408:5 [INFO] [stdout] 35: 0x5588b88fcf9a - functional::test_raffle::{{closure}}::hf0b724b0871d3ead [INFO] [stdout] at /opt/rustwide/workdir/programs/draffle/tests/functional.rs:19:7 [INFO] [stdout] 36: 0x5588b88f097e - core::ops::function::FnOnce::call_once::h721c951d26483b55 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/ops/function.rs:227:5 [INFO] [stdout] 37: 0x5588b89377a3 - core::ops::function::FnOnce::call_once::h24a32b9da1a40fdb [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/ops/function.rs:227:5 [INFO] [stdout] 38: 0x5588b89377a3 - test::__rust_begin_short_backtrace::h3c3a0492fb4a12eb [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/test/src/lib.rs:585:5 [INFO] [stdout] 39: 0x5588b89363b7 - as core::ops::function::FnOnce>::call_once::h9a8e38435f73d5e0 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/alloc/src/boxed.rs:1694:9 [INFO] [stdout] 40: 0x5588b89363b7 - as core::ops::function::FnOnce<()>>::call_once::hb23d7496a0e6d1b4 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/panic/unwind_safe.rs:271:9 [INFO] [stdout] 41: 0x5588b89363b7 - std::panicking::try::do_call::ha2bb9825b32d2cc2 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:406:40 [INFO] [stdout] 42: 0x5588b89363b7 - std::panicking::try::hdc38a574bbebc53e [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:370:19 [INFO] [stdout] 43: 0x5588b89363b7 - std::panic::catch_unwind::hc45ed246595c621c [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panic.rs:133:14 [INFO] [stdout] 44: 0x5588b89363b7 - test::run_test_in_process::h4249138faaea8d54 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/test/src/lib.rs:608:18 [INFO] [stdout] 45: 0x5588b89363b7 - test::run_test::run_test_inner::{{closure}}::h3c1b37669f6e9fd7 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/test/src/lib.rs:500:39 [INFO] [stdout] 46: 0x5588b890365e - test::run_test::run_test_inner::{{closure}}::h388760469edd5c24 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/test/src/lib.rs:527:37 [INFO] [stdout] 47: 0x5588b890365e - 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] 48: 0x5588b89083b8 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::h09cd3ca65896da91 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/thread/mod.rs:484:17 [INFO] [stdout] 49: 0x5588b89083b8 - as core::ops::function::FnOnce<()>>::call_once::hc52dbb4f9088d18b [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/panic/unwind_safe.rs:271:9 [INFO] [stdout] 50: 0x5588b89083b8 - std::panicking::try::do_call::h4485cfee22b11c08 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:406:40 [INFO] [stdout] 51: 0x5588b89083b8 - std::panicking::try::hb62aa8549e20c08b [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:370:19 [INFO] [stdout] 52: 0x5588b89083b8 - std::panic::catch_unwind::ha322c7a5bc666762 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panic.rs:133:14 [INFO] [stdout] 53: 0x5588b89083b8 - std::thread::Builder::spawn_unchecked::{{closure}}::h1076fc1398603b77 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/thread/mod.rs:483:30 [INFO] [stdout] 54: 0x5588b89083b8 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h911e510344167353 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/ops/function.rs:227:5 [INFO] [stdout] 55: 0x5588b9b73f53 - as core::ops::function::FnOnce>::call_once::h771719d52c343434 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/alloc/src/boxed.rs:1694:9 [INFO] [stdout] 56: 0x5588b9b73f53 - as core::ops::function::FnOnce>::call_once::hf441746dfa4b0f57 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/alloc/src/boxed.rs:1694:9 [INFO] [stdout] 57: 0x5588b9b73f53 - 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] 58: 0x7fd718a53609 - start_thread [INFO] [stdout] 59: 0x7fd718829293 - clone [INFO] [stdout] 60: 0x0 - [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] test_raffle [INFO] [stdout] [INFO] [stdout] test result: FAILED. 0 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 66.58s [INFO] [stdout] [INFO] [stderr] error: test failed, to rerun pass '--test functional' [INFO] running `Command { std: "docker" "inspect" "171a8c307a129b641770c1cbaf2400a6dd318fd6c3f46e1c663b96dc193cd15c", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "171a8c307a129b641770c1cbaf2400a6dd318fd6c3f46e1c663b96dc193cd15c", kill_on_drop: false }` [INFO] [stdout] 171a8c307a129b641770c1cbaf2400a6dd318fd6c3f46e1c663b96dc193cd15c