[INFO] cloning repository https://github.com/alvarobrg/RadixToken1
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/alvarobrg/RadixToken1" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Falvarobrg%2FRadixToken1", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Falvarobrg%2FRadixToken1'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 93cf29bc8fb48bdb40d8bf4c67bc833fbe71603b
[INFO] testing alvarobrg/RadixToken1 against beta-2024-12-08 for beta-1.84.0-4-retry
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Falvarobrg%2FRadixToken1" "/workspace/builds/worker-3-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-3-tc2/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/alvarobrg/RadixToken1 on toolchain beta-2024-12-08
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+beta-2024-12-08" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/alvarobrg/RadixToken1
[INFO] finished tweaking git repo https://github.com/alvarobrg/RadixToken1
[INFO] tweaked toml for git repo https://github.com/alvarobrg/RadixToken1 written to /workspace/builds/worker-3-tc2/source/Cargo.toml
[INFO] crate git repo https://github.com/alvarobrg/RadixToken1 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+beta-2024-12-08" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:f3a9d4ad9d972b27faf3965f35b62e55ba32bbce8f20bc8fe909558a86702fde" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2024-12-08" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 582a80e5a19292656aa4a3fcabdf336c109bc891d8c43aa24996d5fbd3a7a2a9
[INFO] running `Command { std: "docker" "start" "-a" "582a80e5a19292656aa4a3fcabdf336c109bc891d8c43aa24996d5fbd3a7a2a9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "582a80e5a19292656aa4a3fcabdf336c109bc891d8c43aa24996d5fbd3a7a2a9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "582a80e5a19292656aa4a3fcabdf336c109bc891d8c43aa24996d5fbd3a7a2a9", kill_on_drop: false }`
[INFO] [stdout] 582a80e5a19292656aa4a3fcabdf336c109bc891d8c43aa24996d5fbd3a7a2a9
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-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:f3a9d4ad9d972b27faf3965f35b62e55ba32bbce8f20bc8fe909558a86702fde" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2024-12-08" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 0360576bc5a14b35c47e57bea28fdd54d9f588dfdc2c5ab05f9107bfcb7986ba
[INFO] running `Command { std: "docker" "start" "-a" "0360576bc5a14b35c47e57bea28fdd54d9f588dfdc2c5ab05f9107bfcb7986ba", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.63
[INFO] [stderr]    Compiling quote v1.0.29
[INFO] [stderr]    Compiling unicode-ident v1.0.9
[INFO] [stderr]    Compiling syn v1.0.109
[INFO] [stderr]    Compiling typenum v1.16.0
[INFO] [stderr]    Compiling version_check v0.9.4
[INFO] [stderr]    Compiling hashbrown v0.13.2
[INFO] [stderr]    Compiling num-traits v0.2.15
[INFO] [stderr]    Compiling const-sha1 v0.2.0 (https://github.com/radixdlt/const-sha1#5e9ae2a9)
[INFO] [stderr]    Compiling num-integer v0.1.45
[INFO] [stderr]    Compiling num-bigint v0.4.3
[INFO] [stderr]    Compiling generic-array v0.14.7
[INFO] [stderr]    Compiling subtle v2.5.0
[INFO] [stderr]    Compiling serde v1.0.164
[INFO] [stderr]    Compiling paste v1.0.12
[INFO] [stderr]    Compiling indexmap v2.0.0-pre (https://github.com/bluss/indexmap?rev=eedabaca9f84e520eab01325b305c08f3773e66c#eedabaca)
[INFO] [stderr]    Compiling hex v0.4.3
[INFO] [stderr]    Compiling bech32 v0.9.1
[INFO] [stderr]    Compiling syn v2.0.23
[INFO] [stderr]    Compiling rustversion v1.0.12
[INFO] [stderr]    Compiling utils v0.9.0 (https://github.com/radixdlt/radixdlt-scrypto?tag=v0.9.0#9d3787ce)
[INFO] [stderr]    Compiling serde_json v1.0.99
[INFO] [stderr]    Compiling heck v0.4.1
[INFO] [stderr]    Compiling itoa v1.0.6
[INFO] [stderr]    Compiling ryu v1.0.13
[INFO] [stderr]    Compiling bnum v0.4.0
[INFO] [stderr]    Compiling block-buffer v0.10.4
[INFO] [stderr]    Compiling crypto-common v0.1.6
[INFO] [stderr]    Compiling digest v0.10.7
[INFO] [stderr]    Compiling blake2 v0.10.6
[INFO] [stderr]    Compiling serde_derive v1.0.164
[INFO] [stderr]    Compiling sbor-derive-common v0.9.0 (https://github.com/radixdlt/radixdlt-scrypto?tag=v0.9.0#9d3787ce)
[INFO] [stderr]    Compiling strum_macros v0.24.3
[INFO] [stderr]    Compiling sbor-derive v0.9.0 (https://github.com/radixdlt/radixdlt-scrypto?tag=v0.9.0#9d3787ce)
[INFO] [stderr]    Compiling radix-engine-derive v0.9.0 (https://github.com/radixdlt/radixdlt-scrypto?tag=v0.9.0#9d3787ce)
[INFO] [stderr]    Compiling sbor v0.9.0 (https://github.com/radixdlt/radixdlt-scrypto?tag=v0.9.0#9d3787ce)
[INFO] [stderr]    Compiling strum v0.24.1
[INFO] [stderr]    Compiling radix-engine-common v0.9.0 (https://github.com/radixdlt/radixdlt-scrypto?tag=v0.9.0#9d3787ce)
[INFO] [stderr]    Compiling scrypto-schema v0.9.0 (https://github.com/radixdlt/radixdlt-scrypto?tag=v0.9.0#9d3787ce)
[INFO] [stderr]    Compiling radix-engine-interface v0.9.0 (https://github.com/radixdlt/radixdlt-scrypto?tag=v0.9.0#9d3787ce)
[INFO] [stderr]    Compiling scrypto-derive v0.9.0 (https://github.com/radixdlt/radixdlt-scrypto?tag=v0.9.0#9d3787ce)
[INFO] [stderr]    Compiling scrypto v0.9.0 (https://github.com/radixdlt/radixdlt-scrypto?tag=v0.9.0#9d3787ce)
[INFO] [stderr]    Compiling RadixToken1 v0.1.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: crate `RadixToken1` should have a snake case name
[INFO] [stdout]   |
[INFO] [stdout]   = help: convert the identifier to snake case: `radix_token1`
[INFO] [stdout]   = note: `#[warn(non_snake_case)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 1m 11s
[INFO] running `Command { std: "docker" "inspect" "0360576bc5a14b35c47e57bea28fdd54d9f588dfdc2c5ab05f9107bfcb7986ba", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "0360576bc5a14b35c47e57bea28fdd54d9f588dfdc2c5ab05f9107bfcb7986ba", kill_on_drop: false }`
[INFO] [stdout] 0360576bc5a14b35c47e57bea28fdd54d9f588dfdc2c5ab05f9107bfcb7986ba
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-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:f3a9d4ad9d972b27faf3965f35b62e55ba32bbce8f20bc8fe909558a86702fde" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2024-12-08" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] cb8bcf67932d50370fa87dd349348f521a42dfc0076b43793b910b5ca803965d
[INFO] running `Command { std: "docker" "start" "-a" "cb8bcf67932d50370fa87dd349348f521a42dfc0076b43793b910b5ca803965d", kill_on_drop: false }`
[INFO] [stderr]    Compiling syn v2.0.23
[INFO] [stderr]    Compiling libc v0.2.147
[INFO] [stderr]    Compiling serde v1.0.164
[INFO] [stderr]    Compiling num-traits v0.2.15
[INFO] [stderr]    Compiling strsim v0.10.0
[INFO] [stderr]    Compiling ident_case v1.0.1
[INFO] [stderr]    Compiling fnv v1.0.7
[INFO] [stderr]    Compiling subtle v2.5.0
[INFO] [stderr]    Compiling cc v1.0.79
[INFO] [stderr]    Compiling getrandom v0.1.16
[INFO] [stderr]    Compiling digest v0.10.7
[INFO] [stderr]    Compiling blake2 v0.10.6
[INFO] [stderr]    Compiling itoa v1.0.6
[INFO] [stderr]    Compiling ryu v1.0.13
[INFO] [stderr]    Compiling lock_api v0.4.10
[INFO] [stderr]    Compiling crossbeam-utils v0.8.16
[INFO] [stderr]    Compiling parking_lot_core v0.9.8
[INFO] [stderr]    Compiling digest v0.9.0
[INFO] [stderr]    Compiling num-integer v0.1.45
[INFO] [stderr]    Compiling memoffset v0.9.0
[INFO] [stderr]    Compiling ppv-lite86 v0.2.17
[INFO] [stderr]    Compiling smallvec v1.10.0
[INFO] [stderr]    Compiling rand_core v0.5.1
[INFO] [stderr]    Compiling secp256k1-sys v0.6.1
[INFO] [stderr]    Compiling libm v0.2.7
[INFO] [stderr]    Compiling hex v0.4.3
[INFO] [stderr]    Compiling rand_chacha v0.2.2
[INFO] [stderr]    Compiling bnum v0.4.0
[INFO] [stderr]    Compiling num-bigint v0.4.3
[INFO] [stderr]    Compiling block-buffer v0.9.0
[INFO] [stderr]    Compiling crossbeam-epoch v0.9.15
[INFO] [stderr]    Compiling byteorder v1.4.3
[INFO] [stderr]    Compiling opaque-debug v0.3.0
[INFO] [stderr]    Compiling signature v1.6.4
[INFO] [stderr]    Compiling cpufeatures v0.2.8
[INFO] [stderr]    Compiling serde_json v1.0.99
[INFO] [stderr]    Compiling thiserror v1.0.40
[INFO] [stderr]    Compiling ed25519 v1.5.3
[INFO] [stderr]    Compiling sha2 v0.9.9
[INFO] [stderr]    Compiling parking_lot v0.12.1
[INFO] [stderr]    Compiling rand v0.7.3
[INFO] [stderr]    Compiling darling_core v0.20.1
[INFO] [stderr]    Compiling getrandom v0.2.10
[INFO] [stderr]    Compiling cmake v0.1.50
[INFO] [stderr]    Compiling indexmap-nostd v0.4.0
[INFO] [stderr]    Compiling moka v0.9.7
[INFO] [stderr]    Compiling downcast-rs v1.2.0
[INFO] [stderr]    Compiling parity-wasm v0.42.2
[INFO] [stderr]    Compiling wasmi_core v0.8.0 (https://github.com/radixdlt/wasmi.git?branch=v0.23.0_store_clone#84085f82)
[INFO] [stderr]    Compiling wasmparser-nostd v0.91.0
[INFO] [stderr]    Compiling secp256k1 v0.24.3
[INFO] [stderr]    Compiling wabt-sys v0.8.0
[INFO] [stderr]    Compiling uuid v1.4.0
[INFO] [stderr]    Compiling scheduled-thread-pool v0.2.7
[INFO] [stderr]    Compiling crossbeam-channel v0.5.8
[INFO] [stderr]    Compiling num_cpus v1.16.0
[INFO] [stderr]    Compiling atty v0.2.14
[INFO] [stderr]    Compiling once_cell v1.18.0
[INFO] [stderr]    Compiling tagptr v0.2.0
[INFO] [stderr]    Compiling spin v0.9.8
[INFO] [stderr]    Compiling triomphe v0.1.8
[INFO] [stderr]    Compiling wasmi_arena v0.3.0 (https://github.com/radixdlt/wasmi.git?branch=v0.23.0_store_clone#84085f82)
[INFO] [stderr]    Compiling radix-engine-constants v0.9.0 (https://github.com/radixdlt/radixdlt-scrypto?tag=v0.9.0#9d3787ce)
[INFO] [stderr]    Compiling colored v2.0.0
[INFO] [stderr]    Compiling wasm-instrument v0.1.1
[INFO] [stderr]    Compiling wasmi-validation v0.4.1
[INFO] [stderr]    Compiling serde_derive v1.0.164
[INFO] [stderr]    Compiling darling_macro v0.20.1
[INFO] [stderr]    Compiling zeroize_derive v1.4.2
[INFO] [stderr]    Compiling thiserror-impl v1.0.40
[INFO] [stderr]    Compiling either v1.8.1
[INFO] [stderr]    Compiling itertools v0.10.5
[INFO] [stderr]    Compiling darling v0.20.1
[INFO] [stderr]    Compiling serde_with_macros v2.3.3
[INFO] [stderr]    Compiling zeroize v1.3.0
[INFO] [stderr]    Compiling curve25519-dalek v3.2.1
[INFO] [stderr]    Compiling wasmi v0.23.0 (https://github.com/radixdlt/wasmi.git?branch=v0.23.0_store_clone#84085f82)
[INFO] [stderr]    Compiling utils v0.9.0 (https://github.com/radixdlt/radixdlt-scrypto?tag=v0.9.0#9d3787ce)
[INFO] [stderr]    Compiling sbor v0.9.0 (https://github.com/radixdlt/radixdlt-scrypto?tag=v0.9.0#9d3787ce)
[INFO] [stderr]    Compiling serde_with v2.3.3
[INFO] [stderr]    Compiling radix-engine-common v0.9.0 (https://github.com/radixdlt/radixdlt-scrypto?tag=v0.9.0#9d3787ce)
[INFO] [stderr]    Compiling ed25519-dalek v1.0.1
[INFO] [stderr]    Compiling scrypto-schema v0.9.0 (https://github.com/radixdlt/radixdlt-scrypto?tag=v0.9.0#9d3787ce)
[INFO] [stderr]    Compiling radix-engine-interface v0.9.0 (https://github.com/radixdlt/radixdlt-scrypto?tag=v0.9.0#9d3787ce)
[INFO] [stderr]    Compiling scrypto-derive v0.9.0 (https://github.com/radixdlt/radixdlt-scrypto?tag=v0.9.0#9d3787ce)
[INFO] [stderr]    Compiling transaction v0.9.0 (https://github.com/radixdlt/radixdlt-scrypto?tag=v0.9.0#9d3787ce)
[INFO] [stderr]    Compiling native-sdk v0.9.0 (https://github.com/radixdlt/radixdlt-scrypto?tag=v0.9.0#9d3787ce)
[INFO] [stderr]    Compiling scrypto v0.9.0 (https://github.com/radixdlt/radixdlt-scrypto?tag=v0.9.0#9d3787ce)
[INFO] [stderr]    Compiling radix-engine v0.9.0 (https://github.com/radixdlt/radixdlt-scrypto?tag=v0.9.0#9d3787ce)
[INFO] [stderr]    Compiling RadixToken1 v0.1.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: crate `RadixToken1` should have a snake case name
[INFO] [stdout]   |
[INFO] [stdout]   = help: convert the identifier to snake case: `radix_token1`
[INFO] [stdout]   = note: `#[warn(non_snake_case)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]    Compiling wabt v0.10.0
[INFO] [stderr]    Compiling radix-engine-stores v0.9.0 (https://github.com/radixdlt/radixdlt-scrypto?tag=v0.9.0#9d3787ce)
[INFO] [stderr]    Compiling scrypto-unit v0.9.0 (https://github.com/radixdlt/radixdlt-scrypto?tag=v0.9.0#9d3787ce)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 4m 58s
[INFO] running `Command { std: "docker" "inspect" "cb8bcf67932d50370fa87dd349348f521a42dfc0076b43793b910b5ca803965d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "cb8bcf67932d50370fa87dd349348f521a42dfc0076b43793b910b5ca803965d", kill_on_drop: false }`
[INFO] [stdout] cb8bcf67932d50370fa87dd349348f521a42dfc0076b43793b910b5ca803965d
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-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:f3a9d4ad9d972b27faf3965f35b62e55ba32bbce8f20bc8fe909558a86702fde" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2024-12-08" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] ad509dff2bd2e5f37e1132e193a377bcd87b029e6c7351741905e13082fd3dc4
[INFO] running `Command { std: "docker" "start" "-a" "ad509dff2bd2e5f37e1132e193a377bcd87b029e6c7351741905e13082fd3dc4", kill_on_drop: false }`
[INFO] [stderr] warning: crate `RadixToken1` should have a snake case name
[INFO] [stderr]   |
[INFO] [stderr]   = help: convert the identifier to snake case: `radix_token1`
[INFO] [stderr]   = note: `#[warn(non_snake_case)]` on by default
[INFO] [stderr] 
[INFO] [stderr] warning: `RadixToken1` (lib) generated 1 warning
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.53s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/RadixToken1-dd52f14120fbf563)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/lib.rs (/opt/rustwide/target/debug/deps/lib-353e2316beb7b428)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stderr]    Compiling autocfg v1.1.0
[INFO] [stderr]    Compiling proc-macro2 v1.0.63
[INFO] [stderr]    Compiling unicode-ident v1.0.9
[INFO] [stderr]    Compiling quote v1.0.29
[INFO] [stderr]    Compiling typenum v1.16.0
[INFO] [stderr]    Compiling version_check v0.9.4
[INFO] [stderr]    Compiling syn v1.0.109
[INFO] [stderr]    Compiling const-sha1 v0.2.0 (https://github.com/radixdlt/const-sha1#5e9ae2a9)
[INFO] [stderr]    Compiling paste v1.0.12
[INFO] [stderr]    Compiling serde v1.0.164
[INFO] [stderr]    Compiling hashbrown v0.13.2
[INFO] [stderr]    Compiling num-traits v0.2.15
[INFO] [stderr]    Compiling num-integer v0.1.45
[INFO] [stderr]    Compiling num-bigint v0.4.3
[INFO] [stderr]    Compiling generic-array v0.14.7
[INFO] [stderr] error[E0463]: can't find crate for `core`
[INFO] [stderr]   |
[INFO] [stderr]   = note: the `wasm32-unknown-unknown` target may not be installed
[INFO] [stderr]   = help: consider downloading the target with `rustup target add wasm32-unknown-unknown`
[INFO] [stderr] 
[INFO] [stderr] For more information about this error, try `rustc --explain E0463`.
[INFO] [stderr] error: could not compile `hashbrown` (lib) due to 1 previous error
[INFO] [stderr] warning: build failed, waiting for other jobs to finish...
[INFO] [stderr] error: could not compile `num-traits` (lib) due to 1 previous error
[INFO] [stderr] error: could not compile `typenum` (lib) due to 1 previous error
[INFO] [stdout] test test_hello ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- test_hello stdout ----
[INFO] [stdout] ------------------------------Transaction Metadata------------------------------
[INFO] [stdout] Transaction hash: 5187ac7ad3885fb2cdc9e42b38bc46e71b7fb19352a8070757b1cbf5ad6fce4b
[INFO] [stdout] Preallocated Node IDs: {}
[INFO] [stdout] Number of blobs: 0
[INFO] [stdout] ------------------------------Engine Execution Log------------------------------
[INFO] [stdout] [0] Creating node: id = AuthZoneStack, init = AuthZoneStack(AuthZoneStackSubstate { auth_zones: [] }), module_init = {TypeInfo: TypeInfo(Object { package_address: NormalPackage[000000000000000000000000000000000000000000000000000009], blueprint_name: "AuthZone", global: false })}
[INFO] [stdout] [0] Invoking: fn = Function(FnIdentifier { package_address: NormalPackage[000000000000000000000000000000000000000000000000000007], blueprint_name: "TransactionProcessor", ident: "run" }), input size = 525
[INFO] [stdout] [0] Sending nodes: []
[INFO] [stdout] [0] Sending refs: {Global(NormalPackage[000000000000000000000000000000000000000000000000000005]), Global(NormalComponent[03ec320a90c7025ad390b44a09614495f5fa0a04e5cebf3281b3d7]), Global(NonFungibleResource[020000000000000000000000000000000000000000000000000003]), Global(NonFungibleResource[020000000000000000000000000000000000000000000000000000]), Global(EpochManagerComponent[050000000000000000000000000000000000000000000000000000]), Global(FungibleResource[010000000000000000000000000000000000000000000000000000]), Global(NonFungibleResource[020000000000000000000000000000000000000000000000000001]), Global(NormalPackage[000000000000000000000000000000000000000000000000000007]), Global(ClockComponent[070000000000000000000000000000000000000000000000000000])}
[INFO] [stdout] [0] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000007]), module_id = SELF, offset = Package(Royalty), flags = MUTABLE
[INFO] [stdout] [0] Substate locked: handle = 0
[INFO] [stdout] [0] Writing substate: handle = 0, size = 0
[INFO] [stdout] [0] Dropping lock: handle = 0 
[INFO] [stdout] [0] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000007]), module_id = SELF, offset = Package(FunctionAccessRules), flags = (empty)
[INFO] [stdout] [0] Substate locked: handle = 1
[INFO] [stdout] [0] Reading substate: handle = 1, size = 0
[INFO] [stdout] [0] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = (empty)
[INFO] [stdout] [0] Substate locked: handle = 2
[INFO] [stdout] [0] Reading substate: handle = 2, size = 0
[INFO] [stdout] [0] Dropping lock: handle = 2 
[INFO] [stdout] [0] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = MUTABLE
[INFO] [stdout] [0] Substate locked: handle = 3
[INFO] [stdout] [0] Writing substate: handle = 3, size = 0
[INFO] [stdout] [0] Dropping lock: handle = 3 
[INFO] [stdout]     [1] Creating node: id = Object("0d5187ac7ad3885fb2cdc9e42b38bc46e71b7fb19352a8070757b100000000"), init = Object({Worktop(Worktop): Worktop(WorktopSubstate { resources: {} })}), module_init = {TypeInfo: TypeInfo(Object { package_address: NormalPackage[000000000000000000000000000000000000000000000000000001], blueprint_name: "Worktop", global: false })}
[INFO] [stdout]     [1] Invoking: fn = Method(MethodIdentifier(Global(NormalComponent[03ec320a90c7025ad390b44a09614495f5fa0a04e5cebf3281b3d7]), SELF, "lock_fee")), input size = 44
[INFO] [stdout]     [1] Locking substate: node id = Global(NormalComponent[03ec320a90c7025ad390b44a09614495f5fa0a04e5cebf3281b3d7]), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 0
[INFO] [stdout]     [1] Reading substate: handle = 0, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 0 
[INFO] [stdout]     [1] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000040]), module_id = SELF, offset = Package(CodeType), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 1
[INFO] [stdout]     [1] Reading substate: handle = 1, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 1 
[INFO] [stdout]     [1] Sending nodes: []
[INFO] [stdout]     [1] Sending refs: {Global(EpochManagerComponent[050000000000000000000000000000000000000000000000000000]), Global(NonFungibleResource[020000000000000000000000000000000000000000000000000003]), Global(NonFungibleResource[020000000000000000000000000000000000000000000000000001]), Global(NormalPackage[000000000000000000000000000000000000000000000000000040]), Global(FungibleResource[010000000000000000000000000000000000000000000000000000]), Global(NonFungibleResource[020000000000000000000000000000000000000000000000000000]), Global(NormalComponent[03ec320a90c7025ad390b44a09614495f5fa0a04e5cebf3281b3d7]), Global(ClockComponent[070000000000000000000000000000000000000000000000000000])}
[INFO] [stdout]     [1] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000040]), module_id = SELF, offset = Package(Royalty), flags = MUTABLE
[INFO] [stdout]     [1] Substate locked: handle = 2
[INFO] [stdout]     [1] Writing substate: handle = 2, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 2 
[INFO] [stdout]     [1] Locking substate: node id = Global(NormalComponent[03ec320a90c7025ad390b44a09614495f5fa0a04e5cebf3281b3d7]), module_id = ComponentRoyalty, offset = Royalty(RoyaltyConfig), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 3
[INFO] [stdout]     [1] Reading substate: handle = 3, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 3 
[INFO] [stdout]     [1] Locking substate: node id = Global(NormalComponent[03ec320a90c7025ad390b44a09614495f5fa0a04e5cebf3281b3d7]), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 4
[INFO] [stdout]     [1] Reading substate: handle = 4, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 4 
[INFO] [stdout]     [1] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000040]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 5
[INFO] [stdout]     [1] Reading substate: handle = 5, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 5 
[INFO] [stdout]     [1] Locking substate: node id = Global(NormalComponent[03ec320a90c7025ad390b44a09614495f5fa0a04e5cebf3281b3d7]), module_id = SELF, offset = Component(State0), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 6
[INFO] [stdout]     [1] Reading substate: handle = 6, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 6 
[INFO] [stdout]     [1] Locking substate: node id = Global(NormalComponent[03ec320a90c7025ad390b44a09614495f5fa0a04e5cebf3281b3d7]), module_id = AccessRules, offset = AccessRules(AccessRules), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 7
[INFO] [stdout]     [1] Reading substate: handle = 7, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 7 
[INFO] [stdout]     [1] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 8
[INFO] [stdout]     [1] Reading substate: handle = 8, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 8 
[INFO] [stdout]     [1] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = MUTABLE
[INFO] [stdout]     [1] Substate locked: handle = 9
[INFO] [stdout]     [1] Writing substate: handle = 9, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 9 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000040]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 0
[INFO] [stdout]         [2] Dropping lock: handle = 0 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000040]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 1
[INFO] [stdout]         [2] Reading substate: handle = 1, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 1 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000040]), module_id = SELF, offset = Package(CodeType), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 2
[INFO] [stdout]         [2] Reading substate: handle = 2, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 2 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000040]), module_id = SELF, offset = Package(Code), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 3
[INFO] [stdout]         [2] Reading substate: handle = 3, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 3 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalComponent[03ec320a90c7025ad390b44a09614495f5fa0a04e5cebf3281b3d7]), module_id = SELF, offset = Component(State0), flags = MUTABLE
[INFO] [stdout]         [2] Substate locked: handle = 4
[INFO] [stdout]         [2] Reading substate: handle = 4, size = 69
[INFO] [stdout]         [2] Invoking: fn = Method(MethodIdentifier(Object("0e81e47a19e6b29b0a65b9591762ce5143ed30d0261e5d24a320172d000000"), SELF, "lock_fee")), input size = 46
[INFO] [stdout]         [2] Locking substate: node id = Object("0e81e47a19e6b29b0a65b9591762ce5143ed30d0261e5d24a320172d000000"), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 5
[INFO] [stdout]         [2] Reading substate: handle = 5, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 5 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(CodeType), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 6
[INFO] [stdout]         [2] Reading substate: handle = 6, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 6 
[INFO] [stdout]         [2] Sending nodes: []
[INFO] [stdout]         [2] Sending refs: {Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), Object("0e81e47a19e6b29b0a65b9591762ce5143ed30d0261e5d24a320172d000000")}
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Royalty), flags = MUTABLE
[INFO] [stdout]         [2] Substate locked: handle = 7
[INFO] [stdout]         [2] Writing substate: handle = 7, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 7 
[INFO] [stdout]         [2] Locking substate: node id = Object("0e81e47a19e6b29b0a65b9591762ce5143ed30d0261e5d24a320172d000000"), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 8
[INFO] [stdout]         [2] Reading substate: handle = 8, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 8 
[INFO] [stdout]         [2] Locking substate: node id = Object("0e81e47a19e6b29b0a65b9591762ce5143ed30d0261e5d24a320172d000000"), module_id = SELF, offset = Vault(Info), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 9
[INFO] [stdout]         [2] Reading substate: handle = 9, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 9 
[INFO] [stdout]         [2] Locking substate: node id = Global(FungibleResource[010000000000000000000000000000000000000000000000000000]), module_id = AccessRules1, offset = AccessRules(AccessRules), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 10
[INFO] [stdout]         [2] Reading substate: handle = 10, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 10 
[INFO] [stdout]         [2] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 11
[INFO] [stdout]         [2] Reading substate: handle = 11, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 11 
[INFO] [stdout]         [2] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = MUTABLE
[INFO] [stdout]         [2] Substate locked: handle = 12
[INFO] [stdout]         [2] Writing substate: handle = 12, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 12 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 0
[INFO] [stdout]             [3] Dropping lock: handle = 0 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 1
[INFO] [stdout]             [3] Reading substate: handle = 1, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 1 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(CodeType), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 2
[INFO] [stdout]             [3] Reading substate: handle = 2, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 2 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Code), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 3
[INFO] [stdout]             [3] Reading substate: handle = 3, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 3 
[INFO] [stdout]             [3] Locking substate: node id = Object("0e81e47a19e6b29b0a65b9591762ce5143ed30d0261e5d24a320172d000000"), module_id = SELF, offset = Vault(Info), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 4
[INFO] [stdout]             [3] Reading substate: handle = 4, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 4 
[INFO] [stdout]             [3] Locking substate: node id = Object("0e81e47a19e6b29b0a65b9591762ce5143ed30d0261e5d24a320172d000000"), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 5
[INFO] [stdout]             [3] Reading substate: handle = 5, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 5 
[INFO] [stdout]             [3] Locking substate: node id = Object("0e81e47a19e6b29b0a65b9591762ce5143ed30d0261e5d24a320172d000000"), module_id = SELF, offset = Vault(LiquidFungible), flags = MUTABLE | UNMODIFIED_BASE | FORCE_WRITE
[INFO] [stdout]             [3] Substate locked: handle = 6
[INFO] [stdout]             [3] Writing substate: handle = 6, size = 0
[INFO] [stdout]             [3] Writing substate: handle = 6, size = 0
[INFO] [stdout]             [3] Locking substate: node id = Object("0e81e47a19e6b29b0a65b9591762ce5143ed30d0261e5d24a320172d000000"), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 7
[INFO] [stdout]             [3] Reading substate: handle = 7, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 7 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 8
[INFO] [stdout]             [3] Reading substate: handle = 8, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 8 
[INFO] [stdout]             [3] Returning nodes: []
[INFO] [stdout]             [3] Returning refs: {}
[INFO] [stdout]             [3] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = MUTABLE
[INFO] [stdout]             [3] Substate locked: handle = 9
[INFO] [stdout]             [3] Writing substate: handle = 9, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 9 
[INFO] [stdout]         [2] Exiting: output size = 0
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalComponent[03ec320a90c7025ad390b44a09614495f5fa0a04e5cebf3281b3d7]), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 13
[INFO] [stdout]         [2] Reading substate: handle = 13, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 13 
[INFO] [stdout]         [2] Writing substate: handle = 4, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 4 
[INFO] [stdout]         [2] Returning nodes: []
[INFO] [stdout]         [2] Returning refs: {}
[INFO] [stdout]         [2] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = MUTABLE
[INFO] [stdout]         [2] Substate locked: handle = 14
[INFO] [stdout]         [2] Writing substate: handle = 14, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 14 
[INFO] [stdout]     [1] Exiting: output size = 0
[INFO] [stdout]     [1] Invoking: fn = Function(FnIdentifier { package_address: NormalPackage[000000000000000000000000000000000000000000000000000005], blueprint_name: "Account", ident: "create_global" }), input size = 120
[INFO] [stdout]     [1] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000005]), module_id = SELF, offset = Package(CodeType), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 10
[INFO] [stdout]     [1] Reading substate: handle = 10, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 10 
[INFO] [stdout]     [1] Sending nodes: []
[INFO] [stdout]     [1] Sending refs: {Global(NonFungibleResource[020000000000000000000000000000000000000000000000000000]), Global(NormalPackage[000000000000000000000000000000000000000000000000000005])}
[INFO] [stdout]     [1] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000005]), module_id = SELF, offset = Package(Royalty), flags = MUTABLE
[INFO] [stdout]     [1] Substate locked: handle = 11
[INFO] [stdout]     [1] Writing substate: handle = 11, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 11 
[INFO] [stdout]     [1] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000005]), module_id = SELF, offset = Package(FunctionAccessRules), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 12
[INFO] [stdout]     [1] Reading substate: handle = 12, size = 0
[INFO] [stdout]     [1] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 13
[INFO] [stdout]     [1] Reading substate: handle = 13, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 13 
[INFO] [stdout]     [1] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = MUTABLE
[INFO] [stdout]     [1] Substate locked: handle = 14
[INFO] [stdout]     [1] Writing substate: handle = 14, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 14 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000005]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 0
[INFO] [stdout]         [2] Dropping lock: handle = 0 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000005]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 1
[INFO] [stdout]         [2] Reading substate: handle = 1, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 1 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000005]), module_id = SELF, offset = Package(CodeType), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 2
[INFO] [stdout]         [2] Reading substate: handle = 2, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 2 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000005]), module_id = SELF, offset = Package(Code), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 3
[INFO] [stdout]         [2] Reading substate: handle = 3, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 3 
[INFO] [stdout]         [2] Creating node: id = KeyValueStore("0f5187ac7ad3885fb2cdc9e42b38bc46e71b7fb19352a8070757b101000000"), init = KeyValueStore, module_init = {TypeInfo: TypeInfo(KeyValueStore(KeyValueStoreSchema { schema: Schema { type_kinds: [Enum { variants: {0: [], 1: [WellKnown(144)]} }], type_metadata: [TypeMetadata { type_name: Some("Option"), child_names: Some(EnumVariants({0: TypeMetadata { type_name: Some("None"), child_names: None }, 1: TypeMetadata { type_name: Some("Some"), child_names: None }})) }], type_validations: [None] }, key: WellKnown(131), value: SchemaLocalIndex(0), can_own: false }))}
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000005]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 4
[INFO] [stdout]         [2] Reading substate: handle = 4, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 4 
[INFO] [stdout]         [2] Creating node: id = Object("0d5187ac7ad3885fb2cdc9e42b38bc46e71b7fb19352a8070757b102000000"), init = Object({Account(Account): Account(AccountSubstate { vaults: KeyValueStore([15, 81, 135, 172, 122, 211, 136, 95, 178, 205, 201, 228, 43, 56, 188, 70, 231, 27, 127, 177, 147, 82, 168, 7, 7, 87, 177, 1, 0, 0, 0]) })}), module_init = {TypeInfo: TypeInfo(Object { package_address: NormalPackage[000000000000000000000000000000000000000000000000000005], blueprint_name: "Account", global: false })}
[INFO] [stdout]         [2] Invoking: fn = Function(FnIdentifier { package_address: NormalPackage[00000000000000000000000000000000000000000000000000000c], blueprint_name: "AccessRules", ident: "create" }), input size = 284
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[00000000000000000000000000000000000000000000000000000c]), module_id = SELF, offset = Package(CodeType), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 5
[INFO] [stdout]         [2] Reading substate: handle = 5, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 5 
[INFO] [stdout]         [2] Sending nodes: []
[INFO] [stdout]         [2] Sending refs: {Global(NormalPackage[00000000000000000000000000000000000000000000000000000c]), Global(NonFungibleResource[020000000000000000000000000000000000000000000000000000])}
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[00000000000000000000000000000000000000000000000000000c]), module_id = SELF, offset = Package(Royalty), flags = MUTABLE
[INFO] [stdout]         [2] Substate locked: handle = 6
[INFO] [stdout]         [2] Writing substate: handle = 6, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 6 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[00000000000000000000000000000000000000000000000000000c]), module_id = SELF, offset = Package(FunctionAccessRules), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 7
[INFO] [stdout]         [2] Reading substate: handle = 7, size = 0
[INFO] [stdout]         [2] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 8
[INFO] [stdout]         [2] Reading substate: handle = 8, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 8 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[00000000000000000000000000000000000000000000000000000c]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 0
[INFO] [stdout]             [3] Dropping lock: handle = 0 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[00000000000000000000000000000000000000000000000000000c]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 1
[INFO] [stdout]             [3] Reading substate: handle = 1, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 1 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[00000000000000000000000000000000000000000000000000000c]), module_id = SELF, offset = Package(CodeType), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 2
[INFO] [stdout]             [3] Reading substate: handle = 2, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 2 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[00000000000000000000000000000000000000000000000000000c]), module_id = SELF, offset = Package(Code), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 3
[INFO] [stdout]             [3] Reading substate: handle = 3, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 3 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[00000000000000000000000000000000000000000000000000000c]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 4
[INFO] [stdout]             [3] Reading substate: handle = 4, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 4 
[INFO] [stdout]             [3] Creating node: id = Object("0d5187ac7ad3885fb2cdc9e42b38bc46e71b7fb19352a8070757b103000000"), init = Object({AccessRules(AccessRules): MethodAccessRules(MethodAccessRulesSubstate { access_rules: AccessRulesConfig { method_auth: {MethodKey { node_module_id: SELF, ident: "deposit" }: AccessRule(AllowAll), MethodKey { node_module_id: SELF, ident: "deposit_batch" }: AccessRule(AllowAll), MethodKey { node_module_id: Metadata, ident: "get" }: AccessRule(AllowAll)}, grouped_auth: {}, default_auth: Protected(ProofRule(Require(StaticNonFungible(NonFungibleResource[020000000000000000000000000000000000000000000000000000]:[b6e84499b83b0797ef5235553eeb7edaa0cea243c1128c2fe737])))), method_auth_mutability: {MethodKey { node_module_id: SELF, ident: "deposit" }: DenyAll, MethodKey { node_module_id: SELF, ident: "deposit_batch" }: DenyAll, MethodKey { node_module_id: Metadata, ident: "get" }: DenyAll}, grouped_auth_mutability: {}, default_auth_mutability: Protected(ProofRule(Require(StaticNonFungible(NonFungibleResource[020000000000000000000000000000000000000000000000000000]:[b6e84499b83b0797ef5235553eeb7edaa0cea243c1128c2fe737])))) } })}), module_init = {TypeInfo: TypeInfo(Object { package_address: NormalPackage[00000000000000000000000000000000000000000000000000000c], blueprint_name: "AccessRules", global: false })}
[INFO] [stdout]             [3] Returning nodes: [Object("0d5187ac7ad3885fb2cdc9e42b38bc46e71b7fb19352a8070757b103000000")]
[INFO] [stdout]             [3] Returning refs: {}
[INFO] [stdout]         [2] Exiting: output size = 0
[INFO] [stdout]         [2] Invoking: fn = Function(FnIdentifier { package_address: NormalPackage[00000000000000000000000000000000000000000000000000000a], blueprint_name: "Metadata", ident: "create" }), input size = 43
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[00000000000000000000000000000000000000000000000000000a]), module_id = SELF, offset = Package(CodeType), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 9
[INFO] [stdout]         [2] Reading substate: handle = 9, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 9 
[INFO] [stdout]         [2] Sending nodes: []
[INFO] [stdout]         [2] Sending refs: {Global(NormalPackage[00000000000000000000000000000000000000000000000000000a])}
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[00000000000000000000000000000000000000000000000000000a]), module_id = SELF, offset = Package(Royalty), flags = MUTABLE
[INFO] [stdout]         [2] Substate locked: handle = 10
[INFO] [stdout]         [2] Writing substate: handle = 10, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 10 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[00000000000000000000000000000000000000000000000000000a]), module_id = SELF, offset = Package(FunctionAccessRules), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 11
[INFO] [stdout]         [2] Reading substate: handle = 11, size = 0
[INFO] [stdout]         [2] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 12
[INFO] [stdout]         [2] Reading substate: handle = 12, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 12 
[INFO] [stdout]         [2] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = MUTABLE
[INFO] [stdout]         [2] Substate locked: handle = 13
[INFO] [stdout]         [2] Writing substate: handle = 13, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 13 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[00000000000000000000000000000000000000000000000000000a]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 0
[INFO] [stdout]             [3] Dropping lock: handle = 0 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[00000000000000000000000000000000000000000000000000000a]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 1
[INFO] [stdout]             [3] Reading substate: handle = 1, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 1 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[00000000000000000000000000000000000000000000000000000a]), module_id = SELF, offset = Package(CodeType), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 2
[INFO] [stdout]             [3] Reading substate: handle = 2, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 2 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[00000000000000000000000000000000000000000000000000000a]), module_id = SELF, offset = Package(Code), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 3
[INFO] [stdout]             [3] Reading substate: handle = 3, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 3 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[00000000000000000000000000000000000000000000000000000a]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 4
[INFO] [stdout]             [3] Reading substate: handle = 4, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 4 
[INFO] [stdout]             [3] Creating node: id = Object("0d5187ac7ad3885fb2cdc9e42b38bc46e71b7fb19352a8070757b104000000"), init = Object({}), module_init = {TypeInfo: TypeInfo(Object { package_address: NormalPackage[00000000000000000000000000000000000000000000000000000a], blueprint_name: "Metadata", global: false })}
[INFO] [stdout]             [3] Returning nodes: [Object("0d5187ac7ad3885fb2cdc9e42b38bc46e71b7fb19352a8070757b104000000")]
[INFO] [stdout]             [3] Returning refs: {}
[INFO] [stdout]             [3] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = MUTABLE
[INFO] [stdout]             [3] Substate locked: handle = 5
[INFO] [stdout]             [3] Writing substate: handle = 5, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 5 
[INFO] [stdout]         [2] Exiting: output size = 0
[INFO] [stdout]         [2] Invoking: fn = Function(FnIdentifier { package_address: NormalPackage[00000000000000000000000000000000000000000000000000000b], blueprint_name: "ComponentRoyalty", ident: "create" }), input size = 62
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[00000000000000000000000000000000000000000000000000000b]), module_id = SELF, offset = Package(CodeType), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 14
[INFO] [stdout]         [2] Reading substate: handle = 14, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 14 
[INFO] [stdout]         [2] Sending nodes: []
[INFO] [stdout]         [2] Sending refs: {Global(NormalPackage[00000000000000000000000000000000000000000000000000000b])}
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[00000000000000000000000000000000000000000000000000000b]), module_id = SELF, offset = Package(Royalty), flags = MUTABLE
[INFO] [stdout]         [2] Substate locked: handle = 15
[INFO] [stdout]         [2] Writing substate: handle = 15, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 15 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[00000000000000000000000000000000000000000000000000000b]), module_id = SELF, offset = Package(FunctionAccessRules), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 16
[INFO] [stdout]         [2] Reading substate: handle = 16, size = 0
[INFO] [stdout]         [2] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 17
[INFO] [stdout]         [2] Reading substate: handle = 17, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 17 
[INFO] [stdout]         [2] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = MUTABLE
[INFO] [stdout]         [2] Substate locked: handle = 18
[INFO] [stdout]         [2] Writing substate: handle = 18, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 18 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[00000000000000000000000000000000000000000000000000000b]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 0
[INFO] [stdout]             [3] Dropping lock: handle = 0 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[00000000000000000000000000000000000000000000000000000b]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 1
[INFO] [stdout]             [3] Reading substate: handle = 1, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 1 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[00000000000000000000000000000000000000000000000000000b]), module_id = SELF, offset = Package(CodeType), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 2
[INFO] [stdout]             [3] Reading substate: handle = 2, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 2 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[00000000000000000000000000000000000000000000000000000b]), module_id = SELF, offset = Package(Code), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 3
[INFO] [stdout]             [3] Reading substate: handle = 3, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 3 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[00000000000000000000000000000000000000000000000000000b]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 4
[INFO] [stdout]             [3] Reading substate: handle = 4, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 4 
[INFO] [stdout]             [3] Creating node: id = Object("0d5187ac7ad3885fb2cdc9e42b38bc46e71b7fb19352a8070757b105000000"), init = Object({Royalty(RoyaltyConfig): ComponentRoyaltyConfig(ComponentRoyaltyConfigSubstate { royalty_config: RoyaltyConfig { rules: {}, default_rule: 0 } }), Royalty(RoyaltyAccumulator): ComponentRoyaltyAccumulator(ComponentRoyaltyAccumulatorSubstate { royalty_vault: None })}), module_init = {TypeInfo: TypeInfo(Object { package_address: NormalPackage[00000000000000000000000000000000000000000000000000000b], blueprint_name: "ComponentRoyalty", global: false })}
[INFO] [stdout]             [3] Returning nodes: [Object("0d5187ac7ad3885fb2cdc9e42b38bc46e71b7fb19352a8070757b105000000")]
[INFO] [stdout]             [3] Returning refs: {}
[INFO] [stdout]             [3] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = MUTABLE
[INFO] [stdout]             [3] Substate locked: handle = 5
[INFO] [stdout]             [3] Writing substate: handle = 5, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 5 
[INFO] [stdout]         [2] Exiting: output size = 0
[INFO] [stdout]         [2] Locking substate: node id = Object("0d5187ac7ad3885fb2cdc9e42b38bc46e71b7fb19352a8070757b102000000"), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 19
[INFO] [stdout]         [2] Reading substate: handle = 19, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 19 
[INFO] [stdout]         [2] Dropping node: id = Object("0d5187ac7ad3885fb2cdc9e42b38bc46e71b7fb19352a8070757b102000000")
[INFO] [stdout]         [2] Locking substate: node id = Object("0d5187ac7ad3885fb2cdc9e42b38bc46e71b7fb19352a8070757b102000000"), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 20
[INFO] [stdout]         [2] Reading substate: handle = 20, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 20 
[INFO] [stdout]         [2] Locking substate: node id = Object("0d5187ac7ad3885fb2cdc9e42b38bc46e71b7fb19352a8070757b104000000"), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 21
[INFO] [stdout]         [2] Reading substate: handle = 21, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 21 
[INFO] [stdout]         [2] Dropping node: id = Object("0d5187ac7ad3885fb2cdc9e42b38bc46e71b7fb19352a8070757b104000000")
[INFO] [stdout]         [2] Locking substate: node id = Object("0d5187ac7ad3885fb2cdc9e42b38bc46e71b7fb19352a8070757b104000000"), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 22
[INFO] [stdout]         [2] Reading substate: handle = 22, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 22 
[INFO] [stdout]         [2] Locking substate: node id = Object("0d5187ac7ad3885fb2cdc9e42b38bc46e71b7fb19352a8070757b103000000"), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 23
[INFO] [stdout]         [2] Reading substate: handle = 23, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 23 
[INFO] [stdout]         [2] Dropping node: id = Object("0d5187ac7ad3885fb2cdc9e42b38bc46e71b7fb19352a8070757b103000000")
[INFO] [stdout]         [2] Locking substate: node id = Object("0d5187ac7ad3885fb2cdc9e42b38bc46e71b7fb19352a8070757b103000000"), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 24
[INFO] [stdout]         [2] Reading substate: handle = 24, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 24 
[INFO] [stdout]         [2] Locking substate: node id = Object("0d5187ac7ad3885fb2cdc9e42b38bc46e71b7fb19352a8070757b105000000"), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 25
[INFO] [stdout]         [2] Reading substate: handle = 25, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 25 
[INFO] [stdout]         [2] Dropping node: id = Object("0d5187ac7ad3885fb2cdc9e42b38bc46e71b7fb19352a8070757b105000000")
[INFO] [stdout]         [2] Locking substate: node id = Object("0d5187ac7ad3885fb2cdc9e42b38bc46e71b7fb19352a8070757b105000000"), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 26
[INFO] [stdout]         [2] Reading substate: handle = 26, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 26 
[INFO] [stdout]         [2] Creating node: id = Global(AccountComponent[048944f6ce22315a26c4b90c6e7e09a093dcbc98c89e67d32b2dc1]), init = GlobalObject({Account(Account): Account(AccountSubstate { vaults: KeyValueStore([15, 81, 135, 172, 122, 211, 136, 95, 178, 205, 201, 228, 43, 56, 188, 70, 231, 27, 127, 177, 147, 82, 168, 7, 7, 87, 177, 1, 0, 0, 0]) })}), module_init = {TypeInfo: TypeInfo(Object { package_address: NormalPackage[000000000000000000000000000000000000000000000000000005], blueprint_name: "Account", global: true }), Metadata: Metadata({}), AccessRules: MethodAccessRules(MethodAccessRulesSubstate { access_rules: AccessRulesConfig { method_auth: {MethodKey { node_module_id: SELF, ident: "deposit" }: AccessRule(AllowAll), MethodKey { node_module_id: SELF, ident: "deposit_batch" }: AccessRule(AllowAll), MethodKey { node_module_id: Metadata, ident: "get" }: AccessRule(AllowAll)}, grouped_auth: {}, default_auth: Protected(ProofRule(Require(StaticNonFungible(NonFungibleResource[020000000000000000000000000000000000000000000000000000]:[b6e84499b83b0797ef5235553eeb7edaa0cea243c1128c2fe737])))), method_auth_mutability: {MethodKey { node_module_id: SELF, ident: "deposit" }: DenyAll, MethodKey { node_module_id: SELF, ident: "deposit_batch" }: DenyAll, MethodKey { node_module_id: Metadata, ident: "get" }: DenyAll}, grouped_auth_mutability: {}, default_auth_mutability: Protected(ProofRule(Require(StaticNonFungible(NonFungibleResource[020000000000000000000000000000000000000000000000000000]:[b6e84499b83b0797ef5235553eeb7edaa0cea243c1128c2fe737])))) } }), ComponentRoyalty: ComponentRoyalty(ComponentRoyaltyConfigSubstate { royalty_config: RoyaltyConfig { rules: {}, default_rule: 0 } }, ComponentRoyaltyAccumulatorSubstate { royalty_vault: None })}
[INFO] [stdout]         [2] Returning nodes: []
[INFO] [stdout]         [2] Returning refs: {Global(AccountComponent[048944f6ce22315a26c4b90c6e7e09a093dcbc98c89e67d32b2dc1])}
[INFO] [stdout]         [2] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = MUTABLE
[INFO] [stdout]         [2] Substate locked: handle = 27
[INFO] [stdout]         [2] Writing substate: handle = 27, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 27 
[INFO] [stdout]     [1] Exiting: output size = 0
[INFO] [stdout]     [1] Invoking: fn = Function(FnIdentifier { package_address: NormalPackage[000000000000000000000000000000000000000000000000000001], blueprint_name: "Worktop", ident: "Worktop_drop" }), input size = 81
[INFO] [stdout]     [1] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(CodeType), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 15
[INFO] [stdout]     [1] Reading substate: handle = 15, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 15 
[INFO] [stdout]     [1] Sending nodes: [Object("0d5187ac7ad3885fb2cdc9e42b38bc46e71b7fb19352a8070757b100000000")]
[INFO] [stdout]     [1] Sending refs: {Global(NormalPackage[000000000000000000000000000000000000000000000000000001])}
[INFO] [stdout]     [1] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Royalty), flags = MUTABLE
[INFO] [stdout]     [1] Substate locked: handle = 16
[INFO] [stdout]     [1] Writing substate: handle = 16, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 16 
[INFO] [stdout]     [1] Locking substate: node id = Object("0d5187ac7ad3885fb2cdc9e42b38bc46e71b7fb19352a8070757b100000000"), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 17
[INFO] [stdout]     [1] Reading substate: handle = 17, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 17 
[INFO] [stdout]     [1] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(FunctionAccessRules), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 18
[INFO] [stdout]     [1] Reading substate: handle = 18, size = 0
[INFO] [stdout]     [1] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 19
[INFO] [stdout]     [1] Reading substate: handle = 19, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 19 
[INFO] [stdout]     [1] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = MUTABLE
[INFO] [stdout]     [1] Substate locked: handle = 20
[INFO] [stdout]     [1] Writing substate: handle = 20, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 20 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 0
[INFO] [stdout]         [2] Dropping lock: handle = 0 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 1
[INFO] [stdout]         [2] Reading substate: handle = 1, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 1 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(CodeType), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 2
[INFO] [stdout]         [2] Reading substate: handle = 2, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 2 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Code), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 3
[INFO] [stdout]         [2] Reading substate: handle = 3, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 3 
[INFO] [stdout]         [2] Dropping node: id = Object("0d5187ac7ad3885fb2cdc9e42b38bc46e71b7fb19352a8070757b100000000")
[INFO] [stdout]         [2] Locking substate: node id = Object("0d5187ac7ad3885fb2cdc9e42b38bc46e71b7fb19352a8070757b100000000"), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 4
[INFO] [stdout]         [2] Reading substate: handle = 4, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 4 
[INFO] [stdout]         [2] Returning nodes: []
[INFO] [stdout]         [2] Returning refs: {}
[INFO] [stdout]         [2] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = MUTABLE
[INFO] [stdout]         [2] Substate locked: handle = 5
[INFO] [stdout]         [2] Writing substate: handle = 5, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 5 
[INFO] [stdout]     [1] Exiting: output size = 0
[INFO] [stdout]     [1] Returning nodes: []
[INFO] [stdout]     [1] Returning refs: {}
[INFO] [stdout]     [1] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = MUTABLE
[INFO] [stdout]     [1] Substate locked: handle = 21
[INFO] [stdout]     [1] Writing substate: handle = 21, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 21 
[INFO] [stdout] [0] Exiting: output size = 0
[INFO] [stdout] [0] Dropping node: id = AuthZoneStack
[INFO] [stdout] ---------------------------------Cost Analysis----------------------------------
[INFO] [stdout] CreateNode                    :      20000
[INFO] [stdout] DropLock                      :      47500
[INFO] [stdout] DropNode                      :      15000
[INFO] [stdout] Invoke                        :      10300
[INFO] [stdout] LockSubstate                  :      51000
[INFO] [stdout] ReadSubstate                  :      36690
[INFO] [stdout] RunNative                     :      27500
[INFO] [stdout] RunSystem                     :       2500
[INFO] [stdout] RunWasm                       :     194330
[INFO] [stdout] TxBaseCost                    :      50000
[INFO] [stdout] TxPayloadCost                 :       1135
[INFO] [stdout] WriteSubstate                 :      12500
[INFO] [stdout] ----------------------------------Cost Totals-----------------------------------
[INFO] [stdout] Total Cost Units Consumed     :     468455
[INFO] [stdout] Cost Unit Limit               :  100000000
[INFO] [stdout] Execution XRD                 :  0.0468455
[INFO] [stdout] Royalty XRD                   :          0
[INFO] [stdout] --------------------------------Application Logs--------------------------------
[INFO] [stdout] -------------------------------------Finish-------------------------------------
[INFO] [stdout] ------------------------------Transaction Metadata------------------------------
[INFO] [stdout] Transaction hash: 54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced0652f963eb78
[INFO] [stdout] Preallocated Node IDs: {}
[INFO] [stdout] Number of blobs: 0
[INFO] [stdout] ------------------------------Engine Execution Log------------------------------
[INFO] [stdout] [0] Creating node: id = AuthZoneStack, init = AuthZoneStack(AuthZoneStackSubstate { auth_zones: [] }), module_init = {TypeInfo: TypeInfo(Object { package_address: NormalPackage[000000000000000000000000000000000000000000000000000009], blueprint_name: "AuthZone", global: false })}
[INFO] [stdout] [0] Invoking: fn = Function(FnIdentifier { package_address: NormalPackage[000000000000000000000000000000000000000000000000000007], blueprint_name: "TransactionProcessor", ident: "run" }), input size = 485
[INFO] [stdout] [0] Sending nodes: []
[INFO] [stdout] [0] Sending refs: {Global(NonFungibleResource[020000000000000000000000000000000000000000000000000000]), Global(NonFungibleResource[020000000000000000000000000000000000000000000000000001]), Global(NormalPackage[000000000000000000000000000000000000000000000000000007]), Global(NormalComponent[03ec320a90c7025ad390b44a09614495f5fa0a04e5cebf3281b3d7]), Global(AccountComponent[048944f6ce22315a26c4b90c6e7e09a093dcbc98c89e67d32b2dc1]), Global(FungibleResource[010000000000000000000000000000000000000000000000000000]), Global(EpochManagerComponent[050000000000000000000000000000000000000000000000000000]), Global(ClockComponent[070000000000000000000000000000000000000000000000000000]), Global(NonFungibleResource[020000000000000000000000000000000000000000000000000003])}
[INFO] [stdout] [0] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000007]), module_id = SELF, offset = Package(Royalty), flags = MUTABLE
[INFO] [stdout] [0] Substate locked: handle = 0
[INFO] [stdout] [0] Writing substate: handle = 0, size = 0
[INFO] [stdout] [0] Dropping lock: handle = 0 
[INFO] [stdout] [0] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000007]), module_id = SELF, offset = Package(FunctionAccessRules), flags = (empty)
[INFO] [stdout] [0] Substate locked: handle = 1
[INFO] [stdout] [0] Reading substate: handle = 1, size = 0
[INFO] [stdout] [0] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = (empty)
[INFO] [stdout] [0] Substate locked: handle = 2
[INFO] [stdout] [0] Reading substate: handle = 2, size = 0
[INFO] [stdout] [0] Dropping lock: handle = 2 
[INFO] [stdout] [0] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = MUTABLE
[INFO] [stdout] [0] Substate locked: handle = 3
[INFO] [stdout] [0] Writing substate: handle = 3, size = 0
[INFO] [stdout] [0] Dropping lock: handle = 3 
[INFO] [stdout]     [1] Creating node: id = Object("0d54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced00000000"), init = Object({Worktop(Worktop): Worktop(WorktopSubstate { resources: {} })}), module_init = {TypeInfo: TypeInfo(Object { package_address: NormalPackage[000000000000000000000000000000000000000000000000000001], blueprint_name: "Worktop", global: false })}
[INFO] [stdout]     [1] Invoking: fn = Method(MethodIdentifier(Global(NormalComponent[03ec320a90c7025ad390b44a09614495f5fa0a04e5cebf3281b3d7]), SELF, "lock_fee")), input size = 44
[INFO] [stdout]     [1] Locking substate: node id = Global(NormalComponent[03ec320a90c7025ad390b44a09614495f5fa0a04e5cebf3281b3d7]), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 0
[INFO] [stdout]     [1] Reading substate: handle = 0, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 0 
[INFO] [stdout]     [1] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000040]), module_id = SELF, offset = Package(CodeType), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 1
[INFO] [stdout]     [1] Reading substate: handle = 1, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 1 
[INFO] [stdout]     [1] Sending nodes: []
[INFO] [stdout]     [1] Sending refs: {Global(NonFungibleResource[020000000000000000000000000000000000000000000000000003]), Global(NormalComponent[03ec320a90c7025ad390b44a09614495f5fa0a04e5cebf3281b3d7]), Global(ClockComponent[070000000000000000000000000000000000000000000000000000]), Global(NonFungibleResource[020000000000000000000000000000000000000000000000000001]), Global(EpochManagerComponent[050000000000000000000000000000000000000000000000000000]), Global(NormalPackage[000000000000000000000000000000000000000000000000000040]), Global(FungibleResource[010000000000000000000000000000000000000000000000000000]), Global(NonFungibleResource[020000000000000000000000000000000000000000000000000000])}
[INFO] [stdout]     [1] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000040]), module_id = SELF, offset = Package(Royalty), flags = MUTABLE
[INFO] [stdout]     [1] Substate locked: handle = 2
[INFO] [stdout]     [1] Writing substate: handle = 2, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 2 
[INFO] [stdout]     [1] Locking substate: node id = Global(NormalComponent[03ec320a90c7025ad390b44a09614495f5fa0a04e5cebf3281b3d7]), module_id = ComponentRoyalty, offset = Royalty(RoyaltyConfig), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 3
[INFO] [stdout]     [1] Reading substate: handle = 3, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 3 
[INFO] [stdout]     [1] Locking substate: node id = Global(NormalComponent[03ec320a90c7025ad390b44a09614495f5fa0a04e5cebf3281b3d7]), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 4
[INFO] [stdout]     [1] Reading substate: handle = 4, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 4 
[INFO] [stdout]     [1] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000040]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 5
[INFO] [stdout]     [1] Reading substate: handle = 5, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 5 
[INFO] [stdout]     [1] Locking substate: node id = Global(NormalComponent[03ec320a90c7025ad390b44a09614495f5fa0a04e5cebf3281b3d7]), module_id = SELF, offset = Component(State0), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 6
[INFO] [stdout]     [1] Reading substate: handle = 6, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 6 
[INFO] [stdout]     [1] Locking substate: node id = Global(NormalComponent[03ec320a90c7025ad390b44a09614495f5fa0a04e5cebf3281b3d7]), module_id = AccessRules, offset = AccessRules(AccessRules), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 7
[INFO] [stdout]     [1] Reading substate: handle = 7, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 7 
[INFO] [stdout]     [1] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 8
[INFO] [stdout]     [1] Reading substate: handle = 8, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 8 
[INFO] [stdout]     [1] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = MUTABLE
[INFO] [stdout]     [1] Substate locked: handle = 9
[INFO] [stdout]     [1] Writing substate: handle = 9, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 9 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000040]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 0
[INFO] [stdout]         [2] Dropping lock: handle = 0 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000040]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 1
[INFO] [stdout]         [2] Reading substate: handle = 1, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 1 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000040]), module_id = SELF, offset = Package(CodeType), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 2
[INFO] [stdout]         [2] Reading substate: handle = 2, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 2 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000040]), module_id = SELF, offset = Package(Code), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 3
[INFO] [stdout]         [2] Reading substate: handle = 3, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 3 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalComponent[03ec320a90c7025ad390b44a09614495f5fa0a04e5cebf3281b3d7]), module_id = SELF, offset = Component(State0), flags = MUTABLE
[INFO] [stdout]         [2] Substate locked: handle = 4
[INFO] [stdout]         [2] Reading substate: handle = 4, size = 69
[INFO] [stdout]         [2] Invoking: fn = Method(MethodIdentifier(Object("0e81e47a19e6b29b0a65b9591762ce5143ed30d0261e5d24a320172d000000"), SELF, "lock_fee")), input size = 46
[INFO] [stdout]         [2] Locking substate: node id = Object("0e81e47a19e6b29b0a65b9591762ce5143ed30d0261e5d24a320172d000000"), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 5
[INFO] [stdout]         [2] Reading substate: handle = 5, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 5 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(CodeType), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 6
[INFO] [stdout]         [2] Reading substate: handle = 6, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 6 
[INFO] [stdout]         [2] Sending nodes: []
[INFO] [stdout]         [2] Sending refs: {Object("0e81e47a19e6b29b0a65b9591762ce5143ed30d0261e5d24a320172d000000"), Global(NormalPackage[000000000000000000000000000000000000000000000000000001])}
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Royalty), flags = MUTABLE
[INFO] [stdout]         [2] Substate locked: handle = 7
[INFO] [stdout]         [2] Writing substate: handle = 7, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 7 
[INFO] [stdout]         [2] Locking substate: node id = Object("0e81e47a19e6b29b0a65b9591762ce5143ed30d0261e5d24a320172d000000"), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 8
[INFO] [stdout]         [2] Reading substate: handle = 8, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 8 
[INFO] [stdout]         [2] Locking substate: node id = Object("0e81e47a19e6b29b0a65b9591762ce5143ed30d0261e5d24a320172d000000"), module_id = SELF, offset = Vault(Info), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 9
[INFO] [stdout]         [2] Reading substate: handle = 9, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 9 
[INFO] [stdout]         [2] Locking substate: node id = Global(FungibleResource[010000000000000000000000000000000000000000000000000000]), module_id = AccessRules1, offset = AccessRules(AccessRules), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 10
[INFO] [stdout]         [2] Reading substate: handle = 10, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 10 
[INFO] [stdout]         [2] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 11
[INFO] [stdout]         [2] Reading substate: handle = 11, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 11 
[INFO] [stdout]         [2] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = MUTABLE
[INFO] [stdout]         [2] Substate locked: handle = 12
[INFO] [stdout]         [2] Writing substate: handle = 12, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 12 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 0
[INFO] [stdout]             [3] Dropping lock: handle = 0 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 1
[INFO] [stdout]             [3] Reading substate: handle = 1, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 1 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(CodeType), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 2
[INFO] [stdout]             [3] Reading substate: handle = 2, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 2 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Code), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 3
[INFO] [stdout]             [3] Reading substate: handle = 3, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 3 
[INFO] [stdout]             [3] Locking substate: node id = Object("0e81e47a19e6b29b0a65b9591762ce5143ed30d0261e5d24a320172d000000"), module_id = SELF, offset = Vault(Info), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 4
[INFO] [stdout]             [3] Reading substate: handle = 4, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 4 
[INFO] [stdout]             [3] Locking substate: node id = Object("0e81e47a19e6b29b0a65b9591762ce5143ed30d0261e5d24a320172d000000"), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 5
[INFO] [stdout]             [3] Reading substate: handle = 5, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 5 
[INFO] [stdout]             [3] Locking substate: node id = Object("0e81e47a19e6b29b0a65b9591762ce5143ed30d0261e5d24a320172d000000"), module_id = SELF, offset = Vault(LiquidFungible), flags = MUTABLE | UNMODIFIED_BASE | FORCE_WRITE
[INFO] [stdout]             [3] Substate locked: handle = 6
[INFO] [stdout]             [3] Writing substate: handle = 6, size = 0
[INFO] [stdout]             [3] Writing substate: handle = 6, size = 0
[INFO] [stdout]             [3] Locking substate: node id = Object("0e81e47a19e6b29b0a65b9591762ce5143ed30d0261e5d24a320172d000000"), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 7
[INFO] [stdout]             [3] Reading substate: handle = 7, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 7 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 8
[INFO] [stdout]             [3] Reading substate: handle = 8, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 8 
[INFO] [stdout]             [3] Returning nodes: []
[INFO] [stdout]             [3] Returning refs: {}
[INFO] [stdout]             [3] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = MUTABLE
[INFO] [stdout]             [3] Substate locked: handle = 9
[INFO] [stdout]             [3] Writing substate: handle = 9, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 9 
[INFO] [stdout]         [2] Exiting: output size = 0
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalComponent[03ec320a90c7025ad390b44a09614495f5fa0a04e5cebf3281b3d7]), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 13
[INFO] [stdout]         [2] Reading substate: handle = 13, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 13 
[INFO] [stdout]         [2] Writing substate: handle = 4, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 4 
[INFO] [stdout]         [2] Returning nodes: []
[INFO] [stdout]         [2] Returning refs: {}
[INFO] [stdout]         [2] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = MUTABLE
[INFO] [stdout]         [2] Substate locked: handle = 14
[INFO] [stdout]         [2] Writing substate: handle = 14, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 14 
[INFO] [stdout]     [1] Exiting: output size = 0
[INFO] [stdout]     [1] Invoking: fn = Method(MethodIdentifier(Global(NormalComponent[03ec320a90c7025ad390b44a09614495f5fa0a04e5cebf3281b3d7]), SELF, "free")), input size = 7
[INFO] [stdout]     [1] Locking substate: node id = Global(NormalComponent[03ec320a90c7025ad390b44a09614495f5fa0a04e5cebf3281b3d7]), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 10
[INFO] [stdout]     [1] Reading substate: handle = 10, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 10 
[INFO] [stdout]     [1] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000040]), module_id = SELF, offset = Package(CodeType), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 11
[INFO] [stdout]     [1] Reading substate: handle = 11, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 11 
[INFO] [stdout]     [1] Sending nodes: []
[INFO] [stdout]     [1] Sending refs: {Global(NormalComponent[03ec320a90c7025ad390b44a09614495f5fa0a04e5cebf3281b3d7]), Global(NormalPackage[000000000000000000000000000000000000000000000000000040]), Global(NonFungibleResource[020000000000000000000000000000000000000000000000000000]), Global(NonFungibleResource[020000000000000000000000000000000000000000000000000001]), Global(ClockComponent[070000000000000000000000000000000000000000000000000000]), Global(EpochManagerComponent[050000000000000000000000000000000000000000000000000000]), Global(FungibleResource[010000000000000000000000000000000000000000000000000000]), Global(NonFungibleResource[020000000000000000000000000000000000000000000000000003])}
[INFO] [stdout]     [1] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000040]), module_id = SELF, offset = Package(Royalty), flags = MUTABLE
[INFO] [stdout]     [1] Substate locked: handle = 12
[INFO] [stdout]     [1] Writing substate: handle = 12, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 12 
[INFO] [stdout]     [1] Locking substate: node id = Global(NormalComponent[03ec320a90c7025ad390b44a09614495f5fa0a04e5cebf3281b3d7]), module_id = ComponentRoyalty, offset = Royalty(RoyaltyConfig), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 13
[INFO] [stdout]     [1] Reading substate: handle = 13, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 13 
[INFO] [stdout]     [1] Locking substate: node id = Global(NormalComponent[03ec320a90c7025ad390b44a09614495f5fa0a04e5cebf3281b3d7]), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 14
[INFO] [stdout]     [1] Reading substate: handle = 14, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 14 
[INFO] [stdout]     [1] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000040]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 15
[INFO] [stdout]     [1] Reading substate: handle = 15, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 15 
[INFO] [stdout]     [1] Locking substate: node id = Global(NormalComponent[03ec320a90c7025ad390b44a09614495f5fa0a04e5cebf3281b3d7]), module_id = SELF, offset = Component(State0), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 16
[INFO] [stdout]     [1] Reading substate: handle = 16, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 16 
[INFO] [stdout]     [1] Locking substate: node id = Global(NormalComponent[03ec320a90c7025ad390b44a09614495f5fa0a04e5cebf3281b3d7]), module_id = AccessRules, offset = AccessRules(AccessRules), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 17
[INFO] [stdout]     [1] Reading substate: handle = 17, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 17 
[INFO] [stdout]     [1] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 18
[INFO] [stdout]     [1] Reading substate: handle = 18, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 18 
[INFO] [stdout]     [1] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = MUTABLE
[INFO] [stdout]     [1] Substate locked: handle = 19
[INFO] [stdout]     [1] Writing substate: handle = 19, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 19 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000040]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 0
[INFO] [stdout]         [2] Dropping lock: handle = 0 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000040]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 1
[INFO] [stdout]         [2] Reading substate: handle = 1, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 1 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000040]), module_id = SELF, offset = Package(CodeType), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 2
[INFO] [stdout]         [2] Reading substate: handle = 2, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 2 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000040]), module_id = SELF, offset = Package(Code), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 3
[INFO] [stdout]         [2] Reading substate: handle = 3, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 3 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalComponent[03ec320a90c7025ad390b44a09614495f5fa0a04e5cebf3281b3d7]), module_id = SELF, offset = Component(State0), flags = MUTABLE
[INFO] [stdout]         [2] Substate locked: handle = 4
[INFO] [stdout]         [2] Reading substate: handle = 4, size = 69
[INFO] [stdout]         [2] Invoking: fn = Method(MethodIdentifier(Global(EpochManagerComponent[050000000000000000000000000000000000000000000000000000]), SELF, "get_current_epoch")), input size = 20
[INFO] [stdout]         [2] Locking substate: node id = Global(EpochManagerComponent[050000000000000000000000000000000000000000000000000000]), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 5
[INFO] [stdout]         [2] Reading substate: handle = 5, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 5 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000003]), module_id = SELF, offset = Package(CodeType), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 6
[INFO] [stdout]         [2] Reading substate: handle = 6, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 6 
[INFO] [stdout]         [2] Sending nodes: []
[INFO] [stdout]         [2] Sending refs: {Global(EpochManagerComponent[050000000000000000000000000000000000000000000000000000]), Global(NormalPackage[000000000000000000000000000000000000000000000000000003])}
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000003]), module_id = SELF, offset = Package(Royalty), flags = MUTABLE
[INFO] [stdout]         [2] Substate locked: handle = 7
[INFO] [stdout]         [2] Writing substate: handle = 7, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 7 
[INFO] [stdout]         [2] Locking substate: node id = Global(EpochManagerComponent[050000000000000000000000000000000000000000000000000000]), module_id = ComponentRoyalty, offset = Royalty(RoyaltyConfig), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 8
[INFO] [stdout]         [2] Reading substate: handle = 8, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 8 
[INFO] [stdout]         [2] Locking substate: node id = Global(EpochManagerComponent[050000000000000000000000000000000000000000000000000000]), module_id = AccessRules, offset = AccessRules(AccessRules), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 9
[INFO] [stdout]         [2] Reading substate: handle = 9, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 9 
[INFO] [stdout]         [2] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 10
[INFO] [stdout]         [2] Reading substate: handle = 10, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 10 
[INFO] [stdout]         [2] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = MUTABLE
[INFO] [stdout]         [2] Substate locked: handle = 11
[INFO] [stdout]         [2] Writing substate: handle = 11, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 11 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000003]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 0
[INFO] [stdout]             [3] Dropping lock: handle = 0 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000003]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 1
[INFO] [stdout]             [3] Reading substate: handle = 1, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 1 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000003]), module_id = SELF, offset = Package(CodeType), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 2
[INFO] [stdout]             [3] Reading substate: handle = 2, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 2 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000003]), module_id = SELF, offset = Package(Code), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 3
[INFO] [stdout]             [3] Reading substate: handle = 3, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 3 
[INFO] [stdout]             [3] Locking substate: node id = Global(EpochManagerComponent[050000000000000000000000000000000000000000000000000000]), module_id = SELF, offset = EpochManager(EpochManager), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 4
[INFO] [stdout]             [3] Reading substate: handle = 4, size = 0
[INFO] [stdout]             [3] Returning nodes: []
[INFO] [stdout]             [3] Returning refs: {}
[INFO] [stdout]             [3] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = MUTABLE
[INFO] [stdout]             [3] Substate locked: handle = 5
[INFO] [stdout]             [3] Writing substate: handle = 5, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 5 
[INFO] [stdout]         [2] Exiting: output size = 0
[INFO] [stdout]         [2] Locking substate: node id = KeyValueStore("0f81e47a19e6b29b0a65b9591762ce5143ed30d0261e5d24a320172e000000"), module_id = SELF, offset = KeyValueStore(Entry([92, 32, 7, 32, 84, 244, 81, 139, 185, 145, 189, 30, 17, 24, 245, 81, 60, 204, 238, 72, 136, 40, 57, 45, 44, 111, 123, 199, 140, 237, 6, 82, 249, 99, 235, 120])), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 12
[INFO] [stdout]         [2] Reading substate: handle = 12, size = 4
[INFO] [stdout]         [2] Dropping lock: handle = 12 
[INFO] [stdout]         [2] Locking substate: node id = KeyValueStore("0f81e47a19e6b29b0a65b9591762ce5143ed30d0261e5d24a320172e000000"), module_id = SELF, offset = KeyValueStore(Entry([92, 32, 7, 32, 84, 244, 81, 139, 185, 145, 189, 30, 17, 24, 245, 81, 60, 204, 238, 72, 136, 40, 57, 45, 44, 111, 123, 199, 140, 237, 6, 82, 249, 99, 235, 120])), flags = MUTABLE
[INFO] [stdout]         [2] Substate locked: handle = 13
[INFO] [stdout]         [2] Locking substate: node id = KeyValueStore("0f81e47a19e6b29b0a65b9591762ce5143ed30d0261e5d24a320172e000000"), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 14
[INFO] [stdout]         [2] Reading substate: handle = 14, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 14 
[INFO] [stdout]         [2] Writing substate: handle = 13, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 13 
[INFO] [stdout]         [2] Invoking: fn = Method(MethodIdentifier(Object("0e81e47a19e6b29b0a65b9591762ce5143ed30d0261e5d24a320172d000000"), SELF, "take")), input size = 40
[INFO] [stdout]         [2] Locking substate: node id = Object("0e81e47a19e6b29b0a65b9591762ce5143ed30d0261e5d24a320172d000000"), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 15
[INFO] [stdout]         [2] Reading substate: handle = 15, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 15 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(CodeType), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 16
[INFO] [stdout]         [2] Reading substate: handle = 16, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 16 
[INFO] [stdout]         [2] Sending nodes: []
[INFO] [stdout]         [2] Sending refs: {Object("0e81e47a19e6b29b0a65b9591762ce5143ed30d0261e5d24a320172d000000"), Global(NormalPackage[000000000000000000000000000000000000000000000000000001])}
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Royalty), flags = MUTABLE
[INFO] [stdout]         [2] Substate locked: handle = 17
[INFO] [stdout]         [2] Writing substate: handle = 17, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 17 
[INFO] [stdout]         [2] Locking substate: node id = Object("0e81e47a19e6b29b0a65b9591762ce5143ed30d0261e5d24a320172d000000"), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 18
[INFO] [stdout]         [2] Reading substate: handle = 18, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 18 
[INFO] [stdout]         [2] Locking substate: node id = Object("0e81e47a19e6b29b0a65b9591762ce5143ed30d0261e5d24a320172d000000"), module_id = SELF, offset = Vault(Info), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 19
[INFO] [stdout]         [2] Reading substate: handle = 19, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 19 
[INFO] [stdout]         [2] Locking substate: node id = Global(FungibleResource[010000000000000000000000000000000000000000000000000000]), module_id = AccessRules1, offset = AccessRules(AccessRules), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 20
[INFO] [stdout]         [2] Reading substate: handle = 20, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 20 
[INFO] [stdout]         [2] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 21
[INFO] [stdout]         [2] Reading substate: handle = 21, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 21 
[INFO] [stdout]         [2] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = MUTABLE
[INFO] [stdout]         [2] Substate locked: handle = 22
[INFO] [stdout]         [2] Writing substate: handle = 22, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 22 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 0
[INFO] [stdout]             [3] Dropping lock: handle = 0 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 1
[INFO] [stdout]             [3] Reading substate: handle = 1, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 1 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(CodeType), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 2
[INFO] [stdout]             [3] Reading substate: handle = 2, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 2 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Code), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 3
[INFO] [stdout]             [3] Reading substate: handle = 3, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 3 
[INFO] [stdout]             [3] Locking substate: node id = Object("0e81e47a19e6b29b0a65b9591762ce5143ed30d0261e5d24a320172d000000"), module_id = SELF, offset = Vault(Info), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 4
[INFO] [stdout]             [3] Reading substate: handle = 4, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 4 
[INFO] [stdout]             [3] Locking substate: node id = Object("0e81e47a19e6b29b0a65b9591762ce5143ed30d0261e5d24a320172d000000"), module_id = SELF, offset = Vault(LiquidFungible), flags = MUTABLE
[INFO] [stdout]             [3] Substate locked: handle = 5
[INFO] [stdout]             [3] Writing substate: handle = 5, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 5 
[INFO] [stdout]             [3] Locking substate: node id = Object("0e81e47a19e6b29b0a65b9591762ce5143ed30d0261e5d24a320172d000000"), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 6
[INFO] [stdout]             [3] Reading substate: handle = 6, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 6 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 7
[INFO] [stdout]             [3] Reading substate: handle = 7, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 7 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 8
[INFO] [stdout]             [3] Reading substate: handle = 8, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 8 
[INFO] [stdout]             [3] Creating node: id = Object("0d54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced01000000"), init = Object({Bucket(Info): BucketInfo(BucketInfoSubstate { resource_address: FungibleResource[010000000000000000000000000000000000000000000000000000], resource_type: Fungible { divisibility: 18 } }), Bucket(LiquidFungible): BucketLiquidFungible(LiquidFungibleResource { amount: 10000 }), Bucket(LockedFungible): BucketLockedFungible(LockedFungibleResource { amounts: {} }), Bucket(LiquidNonFungible): BucketLiquidNonFungible(LiquidNonFungibleResource { ids: {} }), Bucket(LockedNonFungible): BucketLockedNonFungible(LockedNonFungibleResource { ids: {} })}), module_init = {TypeInfo: TypeInfo(Object { package_address: NormalPackage[000000000000000000000000000000000000000000000000000001], blueprint_name: "Bucket", global: false })}
[INFO] [stdout]             [3] Returning nodes: [Object("0d54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced01000000")]
[INFO] [stdout]             [3] Returning refs: {}
[INFO] [stdout]             [3] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = MUTABLE
[INFO] [stdout]             [3] Substate locked: handle = 9
[INFO] [stdout]             [3] Writing substate: handle = 9, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 9 
[INFO] [stdout]         [2] Exiting: output size = 0
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalComponent[03ec320a90c7025ad390b44a09614495f5fa0a04e5cebf3281b3d7]), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 23
[INFO] [stdout]         [2] Reading substate: handle = 23, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 23 
[INFO] [stdout]         [2] Writing substate: handle = 4, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 4 
[INFO] [stdout]         [2] Returning nodes: [Object("0d54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced01000000")]
[INFO] [stdout]         [2] Returning refs: {}
[INFO] [stdout]         [2] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = MUTABLE
[INFO] [stdout]         [2] Substate locked: handle = 24
[INFO] [stdout]         [2] Writing substate: handle = 24, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 24 
[INFO] [stdout]     [1] Exiting: output size = 0
[INFO] [stdout]     [1] Locking substate: node id = Object("0d54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced01000000"), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 20
[INFO] [stdout]     [1] Reading substate: handle = 20, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 20 
[INFO] [stdout]     [1] Invoking: fn = Method(MethodIdentifier(Object("0d54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced00000000"), SELF, "Worktop_put")), input size = 47
[INFO] [stdout]     [1] Locking substate: node id = Object("0d54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced00000000"), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 21
[INFO] [stdout]     [1] Reading substate: handle = 21, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 21 
[INFO] [stdout]     [1] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(CodeType), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 22
[INFO] [stdout]     [1] Reading substate: handle = 22, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 22 
[INFO] [stdout]     [1] Sending nodes: [Object("0d54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced01000000")]
[INFO] [stdout]     [1] Sending refs: {Object("0d54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced00000000"), Global(NormalPackage[000000000000000000000000000000000000000000000000000001])}
[INFO] [stdout]     [1] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Royalty), flags = MUTABLE
[INFO] [stdout]     [1] Substate locked: handle = 23
[INFO] [stdout]     [1] Writing substate: handle = 23, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 23 
[INFO] [stdout]     [1] Locking substate: node id = Object("0d54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced01000000"), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 24
[INFO] [stdout]     [1] Reading substate: handle = 24, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 24 
[INFO] [stdout]     [1] Locking substate: node id = Object("0d54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced00000000"), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 25
[INFO] [stdout]     [1] Reading substate: handle = 25, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 25 
[INFO] [stdout]     [1] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 26
[INFO] [stdout]     [1] Reading substate: handle = 26, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 26 
[INFO] [stdout]     [1] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = MUTABLE
[INFO] [stdout]     [1] Substate locked: handle = 27
[INFO] [stdout]     [1] Writing substate: handle = 27, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 27 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 0
[INFO] [stdout]         [2] Dropping lock: handle = 0 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 1
[INFO] [stdout]         [2] Reading substate: handle = 1, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 1 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(CodeType), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 2
[INFO] [stdout]         [2] Reading substate: handle = 2, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 2 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Code), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 3
[INFO] [stdout]         [2] Reading substate: handle = 3, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 3 
[INFO] [stdout]         [2] Invoking: fn = Method(MethodIdentifier(Object("0d54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced01000000"), SELF, "Bucket_get_resource_address")), input size = 30
[INFO] [stdout]         [2] Locking substate: node id = Object("0d54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced01000000"), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 4
[INFO] [stdout]         [2] Reading substate: handle = 4, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 4 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(CodeType), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 5
[INFO] [stdout]         [2] Reading substate: handle = 5, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 5 
[INFO] [stdout]         [2] Sending nodes: []
[INFO] [stdout]         [2] Sending refs: {Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), Object("0d54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced01000000")}
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Royalty), flags = MUTABLE
[INFO] [stdout]         [2] Substate locked: handle = 6
[INFO] [stdout]         [2] Writing substate: handle = 6, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 6 
[INFO] [stdout]         [2] Locking substate: node id = Object("0d54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced01000000"), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 7
[INFO] [stdout]         [2] Reading substate: handle = 7, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 7 
[INFO] [stdout]         [2] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 8
[INFO] [stdout]         [2] Reading substate: handle = 8, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 8 
[INFO] [stdout]         [2] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = MUTABLE
[INFO] [stdout]         [2] Substate locked: handle = 9
[INFO] [stdout]         [2] Writing substate: handle = 9, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 9 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 0
[INFO] [stdout]             [3] Dropping lock: handle = 0 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 1
[INFO] [stdout]             [3] Reading substate: handle = 1, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 1 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(CodeType), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 2
[INFO] [stdout]             [3] Reading substate: handle = 2, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 2 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Code), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 3
[INFO] [stdout]             [3] Reading substate: handle = 3, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 3 
[INFO] [stdout]             [3] Locking substate: node id = Object("0d54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced01000000"), module_id = SELF, offset = Bucket(Info), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 4
[INFO] [stdout]             [3] Reading substate: handle = 4, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 4 
[INFO] [stdout]             [3] Returning nodes: []
[INFO] [stdout]             [3] Returning refs: {Global(FungibleResource[010000000000000000000000000000000000000000000000000000])}
[INFO] [stdout]             [3] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = MUTABLE
[INFO] [stdout]             [3] Substate locked: handle = 5
[INFO] [stdout]             [3] Writing substate: handle = 5, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 5 
[INFO] [stdout]         [2] Exiting: output size = 0
[INFO] [stdout]         [2] Invoking: fn = Method(MethodIdentifier(Object("0d54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced01000000"), SELF, "Bucket_get_amount")), input size = 20
[INFO] [stdout]         [2] Locking substate: node id = Object("0d54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced01000000"), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 10
[INFO] [stdout]         [2] Reading substate: handle = 10, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 10 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(CodeType), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 11
[INFO] [stdout]         [2] Reading substate: handle = 11, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 11 
[INFO] [stdout]         [2] Sending nodes: []
[INFO] [stdout]         [2] Sending refs: {Object("0d54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced01000000"), Global(NormalPackage[000000000000000000000000000000000000000000000000000001])}
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Royalty), flags = MUTABLE
[INFO] [stdout]         [2] Substate locked: handle = 12
[INFO] [stdout]         [2] Writing substate: handle = 12, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 12 
[INFO] [stdout]         [2] Locking substate: node id = Object("0d54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced01000000"), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 13
[INFO] [stdout]         [2] Reading substate: handle = 13, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 13 
[INFO] [stdout]         [2] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 14
[INFO] [stdout]         [2] Reading substate: handle = 14, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 14 
[INFO] [stdout]         [2] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = MUTABLE
[INFO] [stdout]         [2] Substate locked: handle = 15
[INFO] [stdout]         [2] Writing substate: handle = 15, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 15 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 0
[INFO] [stdout]             [3] Dropping lock: handle = 0 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 1
[INFO] [stdout]             [3] Reading substate: handle = 1, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 1 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(CodeType), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 2
[INFO] [stdout]             [3] Reading substate: handle = 2, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 2 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Code), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 3
[INFO] [stdout]             [3] Reading substate: handle = 3, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 3 
[INFO] [stdout]             [3] Locking substate: node id = Object("0d54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced01000000"), module_id = SELF, offset = Bucket(Info), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 4
[INFO] [stdout]             [3] Reading substate: handle = 4, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 4 
[INFO] [stdout]             [3] Locking substate: node id = Object("0d54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced01000000"), module_id = SELF, offset = Bucket(LiquidFungible), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 5
[INFO] [stdout]             [3] Reading substate: handle = 5, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 5 
[INFO] [stdout]             [3] Locking substate: node id = Object("0d54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced01000000"), module_id = SELF, offset = Bucket(LockedFungible), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 6
[INFO] [stdout]             [3] Reading substate: handle = 6, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 6 
[INFO] [stdout]             [3] Returning nodes: []
[INFO] [stdout]             [3] Returning refs: {}
[INFO] [stdout]             [3] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = MUTABLE
[INFO] [stdout]             [3] Substate locked: handle = 7
[INFO] [stdout]             [3] Writing substate: handle = 7, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 7 
[INFO] [stdout]         [2] Exiting: output size = 0
[INFO] [stdout]         [2] Locking substate: node id = Object("0d54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced00000000"), module_id = SELF, offset = Worktop(Worktop), flags = MUTABLE
[INFO] [stdout]         [2] Substate locked: handle = 16
[INFO] [stdout]         [2] Writing substate: handle = 16, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 16 
[INFO] [stdout]         [2] Returning nodes: []
[INFO] [stdout]         [2] Returning refs: {}
[INFO] [stdout]         [2] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = MUTABLE
[INFO] [stdout]         [2] Substate locked: handle = 17
[INFO] [stdout]         [2] Writing substate: handle = 17, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 17 
[INFO] [stdout]     [1] Exiting: output size = 0
[INFO] [stdout]     [1] Invoking: fn = Method(MethodIdentifier(Object("0d54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced00000000"), SELF, "Worktop_drain")), input size = 16
[INFO] [stdout]     [1] Locking substate: node id = Object("0d54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced00000000"), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 28
[INFO] [stdout]     [1] Reading substate: handle = 28, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 28 
[INFO] [stdout]     [1] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(CodeType), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 29
[INFO] [stdout]     [1] Reading substate: handle = 29, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 29 
[INFO] [stdout]     [1] Sending nodes: []
[INFO] [stdout]     [1] Sending refs: {Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), Object("0d54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced00000000")}
[INFO] [stdout]     [1] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Royalty), flags = MUTABLE
[INFO] [stdout]     [1] Substate locked: handle = 30
[INFO] [stdout]     [1] Writing substate: handle = 30, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 30 
[INFO] [stdout]     [1] Locking substate: node id = Object("0d54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced00000000"), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 31
[INFO] [stdout]     [1] Reading substate: handle = 31, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 31 
[INFO] [stdout]     [1] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 32
[INFO] [stdout]     [1] Reading substate: handle = 32, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 32 
[INFO] [stdout]     [1] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = MUTABLE
[INFO] [stdout]     [1] Substate locked: handle = 33
[INFO] [stdout]     [1] Writing substate: handle = 33, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 33 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 0
[INFO] [stdout]         [2] Dropping lock: handle = 0 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 1
[INFO] [stdout]         [2] Reading substate: handle = 1, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 1 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(CodeType), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 2
[INFO] [stdout]         [2] Reading substate: handle = 2, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 2 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Code), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 3
[INFO] [stdout]         [2] Reading substate: handle = 3, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 3 
[INFO] [stdout]         [2] Locking substate: node id = Object("0d54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced00000000"), module_id = SELF, offset = Worktop(Worktop), flags = MUTABLE
[INFO] [stdout]         [2] Substate locked: handle = 4
[INFO] [stdout]         [2] Writing substate: handle = 4, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 4 
[INFO] [stdout]         [2] Returning nodes: [Object("0d54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced01000000")]
[INFO] [stdout]         [2] Returning refs: {}
[INFO] [stdout]         [2] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = MUTABLE
[INFO] [stdout]         [2] Substate locked: handle = 5
[INFO] [stdout]         [2] Writing substate: handle = 5, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 5 
[INFO] [stdout]     [1] Exiting: output size = 0
[INFO] [stdout]     [1] Invoking: fn = Method(MethodIdentifier(Global(AccountComponent[048944f6ce22315a26c4b90c6e7e09a093dcbc98c89e67d32b2dc1]), SELF, "deposit_batch")), input size = 51
[INFO] [stdout]     [1] Locking substate: node id = Global(AccountComponent[048944f6ce22315a26c4b90c6e7e09a093dcbc98c89e67d32b2dc1]), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 34
[INFO] [stdout]     [1] Reading substate: handle = 34, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 34 
[INFO] [stdout]     [1] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000005]), module_id = SELF, offset = Package(CodeType), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 35
[INFO] [stdout]     [1] Reading substate: handle = 35, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 35 
[INFO] [stdout]     [1] Sending nodes: [Object("0d54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced01000000")]
[INFO] [stdout]     [1] Sending refs: {Global(AccountComponent[048944f6ce22315a26c4b90c6e7e09a093dcbc98c89e67d32b2dc1]), Global(NormalPackage[000000000000000000000000000000000000000000000000000005])}
[INFO] [stdout]     [1] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000005]), module_id = SELF, offset = Package(Royalty), flags = MUTABLE
[INFO] [stdout]     [1] Substate locked: handle = 36
[INFO] [stdout]     [1] Writing substate: handle = 36, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 36 
[INFO] [stdout]     [1] Locking substate: node id = Global(AccountComponent[048944f6ce22315a26c4b90c6e7e09a093dcbc98c89e67d32b2dc1]), module_id = ComponentRoyalty, offset = Royalty(RoyaltyConfig), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 37
[INFO] [stdout]     [1] Reading substate: handle = 37, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 37 
[INFO] [stdout]     [1] Locking substate: node id = Object("0d54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced01000000"), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 38
[INFO] [stdout]     [1] Reading substate: handle = 38, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 38 
[INFO] [stdout]     [1] Locking substate: node id = Global(AccountComponent[048944f6ce22315a26c4b90c6e7e09a093dcbc98c89e67d32b2dc1]), module_id = AccessRules, offset = AccessRules(AccessRules), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 39
[INFO] [stdout]     [1] Reading substate: handle = 39, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 39 
[INFO] [stdout]     [1] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 40
[INFO] [stdout]     [1] Reading substate: handle = 40, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 40 
[INFO] [stdout]     [1] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = MUTABLE
[INFO] [stdout]     [1] Substate locked: handle = 41
[INFO] [stdout]     [1] Writing substate: handle = 41, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 41 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000005]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 0
[INFO] [stdout]         [2] Dropping lock: handle = 0 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000005]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 1
[INFO] [stdout]         [2] Reading substate: handle = 1, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 1 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000005]), module_id = SELF, offset = Package(CodeType), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 2
[INFO] [stdout]         [2] Reading substate: handle = 2, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 2 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000005]), module_id = SELF, offset = Package(Code), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 3
[INFO] [stdout]         [2] Reading substate: handle = 3, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 3 
[INFO] [stdout]         [2] Locking substate: node id = Global(AccountComponent[048944f6ce22315a26c4b90c6e7e09a093dcbc98c89e67d32b2dc1]), module_id = SELF, offset = Account(Account), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 4
[INFO] [stdout]         [2] Invoking: fn = Method(MethodIdentifier(Object("0d54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced01000000"), SELF, "Bucket_get_resource_address")), input size = 30
[INFO] [stdout]         [2] Locking substate: node id = Object("0d54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced01000000"), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 5
[INFO] [stdout]         [2] Reading substate: handle = 5, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 5 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(CodeType), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 6
[INFO] [stdout]         [2] Reading substate: handle = 6, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 6 
[INFO] [stdout]         [2] Sending nodes: []
[INFO] [stdout]         [2] Sending refs: {Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), Object("0d54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced01000000")}
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Royalty), flags = MUTABLE
[INFO] [stdout]         [2] Substate locked: handle = 7
[INFO] [stdout]         [2] Writing substate: handle = 7, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 7 
[INFO] [stdout]         [2] Locking substate: node id = Object("0d54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced01000000"), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 8
[INFO] [stdout]         [2] Reading substate: handle = 8, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 8 
[INFO] [stdout]         [2] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 9
[INFO] [stdout]         [2] Reading substate: handle = 9, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 9 
[INFO] [stdout]         [2] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = MUTABLE
[INFO] [stdout]         [2] Substate locked: handle = 10
[INFO] [stdout]         [2] Writing substate: handle = 10, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 10 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 0
[INFO] [stdout]             [3] Dropping lock: handle = 0 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 1
[INFO] [stdout]             [3] Reading substate: handle = 1, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 1 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(CodeType), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 2
[INFO] [stdout]             [3] Reading substate: handle = 2, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 2 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Code), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 3
[INFO] [stdout]             [3] Reading substate: handle = 3, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 3 
[INFO] [stdout]             [3] Locking substate: node id = Object("0d54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced01000000"), module_id = SELF, offset = Bucket(Info), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 4
[INFO] [stdout]             [3] Reading substate: handle = 4, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 4 
[INFO] [stdout]             [3] Returning nodes: []
[INFO] [stdout]             [3] Returning refs: {Global(FungibleResource[010000000000000000000000000000000000000000000000000000])}
[INFO] [stdout]             [3] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = MUTABLE
[INFO] [stdout]             [3] Substate locked: handle = 5
[INFO] [stdout]             [3] Writing substate: handle = 5, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 5 
[INFO] [stdout]         [2] Exiting: output size = 0
[INFO] [stdout]         [2] Reading substate: handle = 4, size = 0
[INFO] [stdout]         [2] Locking substate: node id = KeyValueStore("0f5187ac7ad3885fb2cdc9e42b38bc46e71b7fb19352a8070757b101000000"), module_id = SELF, offset = KeyValueStore(Entry([92, 128, 1, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0])), flags = MUTABLE
[INFO] [stdout]         [2] Substate locked: handle = 11
[INFO] [stdout]         [2] Reading substate: handle = 11, size = 0
[INFO] [stdout]         [2] Invoking: fn = Method(MethodIdentifier(Global(FungibleResource[010000000000000000000000000000000000000000000000000000]), SELF, "create_vault")), input size = 15
[INFO] [stdout]         [2] Locking substate: node id = Global(FungibleResource[010000000000000000000000000000000000000000000000000000]), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 12
[INFO] [stdout]         [2] Reading substate: handle = 12, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 12 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(CodeType), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 13
[INFO] [stdout]         [2] Reading substate: handle = 13, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 13 
[INFO] [stdout]         [2] Sending nodes: []
[INFO] [stdout]         [2] Sending refs: {Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), Global(FungibleResource[010000000000000000000000000000000000000000000000000000])}
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Royalty), flags = MUTABLE
[INFO] [stdout]         [2] Substate locked: handle = 14
[INFO] [stdout]         [2] Writing substate: handle = 14, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 14 
[INFO] [stdout]         [2] Locking substate: node id = Global(FungibleResource[010000000000000000000000000000000000000000000000000000]), module_id = AccessRules, offset = AccessRules(AccessRules), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 15
[INFO] [stdout]         [2] Reading substate: handle = 15, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 15 
[INFO] [stdout]         [2] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 16
[INFO] [stdout]         [2] Reading substate: handle = 16, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 16 
[INFO] [stdout]         [2] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = MUTABLE
[INFO] [stdout]         [2] Substate locked: handle = 17
[INFO] [stdout]         [2] Writing substate: handle = 17, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 17 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 0
[INFO] [stdout]             [3] Dropping lock: handle = 0 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 1
[INFO] [stdout]             [3] Reading substate: handle = 1, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 1 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(CodeType), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 2
[INFO] [stdout]             [3] Reading substate: handle = 2, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 2 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Code), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 3
[INFO] [stdout]             [3] Reading substate: handle = 3, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 3 
[INFO] [stdout]             [3] Locking substate: node id = Global(FungibleResource[010000000000000000000000000000000000000000000000000000]), module_id = SELF, offset = ResourceManager(ResourceManager), flags = MUTABLE
[INFO] [stdout]             [3] Substate locked: handle = 4
[INFO] [stdout]             [3] Reading substate: handle = 4, size = 0
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 5
[INFO] [stdout]             [3] Reading substate: handle = 5, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 5 
[INFO] [stdout]             [3] Creating node: id = Object("0e54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced02000000"), init = Object({Vault(Info): VaultInfo(VaultInfoSubstate { resource_address: FungibleResource[010000000000000000000000000000000000000000000000000000], resource_type: Fungible { divisibility: 18 } }), Vault(LiquidFungible): VaultLiquidFungible(LiquidFungibleResource { amount: 0 }), Vault(LockedFungible): VaultLockedFungible(LockedFungibleResource { amounts: {} }), Vault(LiquidNonFungible): VaultLiquidNonFungible(LiquidNonFungibleResource { ids: {} }), Vault(LockedNonFungible): VaultLockedNonFungible(LockedNonFungibleResource { ids: {} })}), module_init = {TypeInfo: TypeInfo(Object { package_address: NormalPackage[000000000000000000000000000000000000000000000000000001], blueprint_name: "Vault", global: false })}
[INFO] [stdout]             [3] Locking substate: node id = Global(FungibleResource[010000000000000000000000000000000000000000000000000000]), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 6
[INFO] [stdout]             [3] Reading substate: handle = 6, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 6 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 7
[INFO] [stdout]             [3] Reading substate: handle = 7, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 7 
[INFO] [stdout]             [3] Returning nodes: [Object("0e54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced02000000")]
[INFO] [stdout]             [3] Returning refs: {}
[INFO] [stdout]             [3] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = MUTABLE
[INFO] [stdout]             [3] Substate locked: handle = 8
[INFO] [stdout]             [3] Writing substate: handle = 8, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 8 
[INFO] [stdout]         [2] Exiting: output size = 0
[INFO] [stdout]         [2] Writing substate: handle = 11, size = 0
[INFO] [stdout]         [2] Invoking: fn = Method(MethodIdentifier(Object("0e54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced02000000"), SELF, "put")), input size = 39
[INFO] [stdout]         [2] Locking substate: node id = Object("0e54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced02000000"), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 18
[INFO] [stdout]         [2] Reading substate: handle = 18, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 18 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(CodeType), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 19
[INFO] [stdout]         [2] Reading substate: handle = 19, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 19 
[INFO] [stdout]         [2] Sending nodes: [Object("0d54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced01000000")]
[INFO] [stdout]         [2] Sending refs: {Object("0e54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced02000000"), Global(NormalPackage[000000000000000000000000000000000000000000000000000001])}
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Royalty), flags = MUTABLE
[INFO] [stdout]         [2] Substate locked: handle = 20
[INFO] [stdout]         [2] Writing substate: handle = 20, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 20 
[INFO] [stdout]         [2] Locking substate: node id = Object("0d54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced01000000"), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 21
[INFO] [stdout]         [2] Reading substate: handle = 21, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 21 
[INFO] [stdout]         [2] Locking substate: node id = Object("0e54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced02000000"), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 22
[INFO] [stdout]         [2] Reading substate: handle = 22, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 22 
[INFO] [stdout]         [2] Locking substate: node id = Object("0e54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced02000000"), module_id = SELF, offset = Vault(Info), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 23
[INFO] [stdout]         [2] Reading substate: handle = 23, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 23 
[INFO] [stdout]         [2] Locking substate: node id = Global(FungibleResource[010000000000000000000000000000000000000000000000000000]), module_id = AccessRules1, offset = AccessRules(AccessRules), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 24
[INFO] [stdout]         [2] Reading substate: handle = 24, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 24 
[INFO] [stdout]         [2] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 25
[INFO] [stdout]         [2] Reading substate: handle = 25, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 25 
[INFO] [stdout]         [2] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = MUTABLE
[INFO] [stdout]         [2] Substate locked: handle = 26
[INFO] [stdout]         [2] Writing substate: handle = 26, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 26 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 0
[INFO] [stdout]             [3] Dropping lock: handle = 0 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 1
[INFO] [stdout]             [3] Reading substate: handle = 1, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 1 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(CodeType), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 2
[INFO] [stdout]             [3] Reading substate: handle = 2, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 2 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Code), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 3
[INFO] [stdout]             [3] Reading substate: handle = 3, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 3 
[INFO] [stdout]             [3] Dropping node: id = Object("0d54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced01000000")
[INFO] [stdout]             [3] Locking substate: node id = Object("0d54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced01000000"), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 4
[INFO] [stdout]             [3] Reading substate: handle = 4, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 4 
[INFO] [stdout]             [3] Locking substate: node id = Object("0e54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced02000000"), module_id = SELF, offset = Vault(Info), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 5
[INFO] [stdout]             [3] Reading substate: handle = 5, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 5 
[INFO] [stdout]             [3] Locking substate: node id = Object("0e54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced02000000"), module_id = SELF, offset = Vault(LiquidFungible), flags = MUTABLE
[INFO] [stdout]             [3] Substate locked: handle = 6
[INFO] [stdout]             [3] Writing substate: handle = 6, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 6 
[INFO] [stdout]             [3] Locking substate: node id = Object("0e54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced02000000"), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 7
[INFO] [stdout]             [3] Reading substate: handle = 7, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 7 
[INFO] [stdout]             [3] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]             [3] Substate locked: handle = 8
[INFO] [stdout]             [3] Reading substate: handle = 8, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 8 
[INFO] [stdout]             [3] Returning nodes: []
[INFO] [stdout]             [3] Returning refs: {}
[INFO] [stdout]             [3] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = MUTABLE
[INFO] [stdout]             [3] Substate locked: handle = 9
[INFO] [stdout]             [3] Writing substate: handle = 9, size = 0
[INFO] [stdout]             [3] Dropping lock: handle = 9 
[INFO] [stdout]         [2] Exiting: output size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 11 
[INFO] [stdout]         [2] Dropping lock: handle = 4 
[INFO] [stdout]         [2] Returning nodes: []
[INFO] [stdout]         [2] Returning refs: {}
[INFO] [stdout]         [2] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = MUTABLE
[INFO] [stdout]         [2] Substate locked: handle = 27
[INFO] [stdout]         [2] Writing substate: handle = 27, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 27 
[INFO] [stdout]     [1] Exiting: output size = 0
[INFO] [stdout]     [1] Invoking: fn = Function(FnIdentifier { package_address: NormalPackage[000000000000000000000000000000000000000000000000000001], blueprint_name: "Worktop", ident: "Worktop_drop" }), input size = 81
[INFO] [stdout]     [1] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(CodeType), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 42
[INFO] [stdout]     [1] Reading substate: handle = 42, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 42 
[INFO] [stdout]     [1] Sending nodes: [Object("0d54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced00000000")]
[INFO] [stdout]     [1] Sending refs: {Global(NormalPackage[000000000000000000000000000000000000000000000000000001])}
[INFO] [stdout]     [1] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Royalty), flags = MUTABLE
[INFO] [stdout]     [1] Substate locked: handle = 43
[INFO] [stdout]     [1] Writing substate: handle = 43, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 43 
[INFO] [stdout]     [1] Locking substate: node id = Object("0d54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced00000000"), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 44
[INFO] [stdout]     [1] Reading substate: handle = 44, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 44 
[INFO] [stdout]     [1] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(FunctionAccessRules), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 45
[INFO] [stdout]     [1] Reading substate: handle = 45, size = 0
[INFO] [stdout]     [1] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = (empty)
[INFO] [stdout]     [1] Substate locked: handle = 46
[INFO] [stdout]     [1] Reading substate: handle = 46, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 46 
[INFO] [stdout]     [1] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = MUTABLE
[INFO] [stdout]     [1] Substate locked: handle = 47
[INFO] [stdout]     [1] Writing substate: handle = 47, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 47 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 0
[INFO] [stdout]         [2] Dropping lock: handle = 0 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Info), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 1
[INFO] [stdout]         [2] Reading substate: handle = 1, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 1 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(CodeType), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 2
[INFO] [stdout]         [2] Reading substate: handle = 2, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 2 
[INFO] [stdout]         [2] Locking substate: node id = Global(NormalPackage[000000000000000000000000000000000000000000000000000001]), module_id = SELF, offset = Package(Code), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 3
[INFO] [stdout]         [2] Reading substate: handle = 3, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 3 
[INFO] [stdout]         [2] Dropping node: id = Object("0d54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced00000000")
[INFO] [stdout]         [2] Locking substate: node id = Object("0d54f4518bb991bd1e1118f5513cccee488828392d2c6f7bc78ced00000000"), module_id = TypeInfo, offset = TypeInfo(TypeInfo), flags = (empty)
[INFO] [stdout]         [2] Substate locked: handle = 4
[INFO] [stdout]         [2] Reading substate: handle = 4, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 4 
[INFO] [stdout]         [2] Returning nodes: []
[INFO] [stdout]         [2] Returning refs: {}
[INFO] [stdout]         [2] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = MUTABLE
[INFO] [stdout]         [2] Substate locked: handle = 5
[INFO] [stdout]         [2] Writing substate: handle = 5, size = 0
[INFO] [stdout]         [2] Dropping lock: handle = 5 
[INFO] [stdout]     [1] Exiting: output size = 0
[INFO] [stdout]     [1] Returning nodes: []
[INFO] [stdout]     [1] Returning refs: {}
[INFO] [stdout]     [1] Locking substate: node id = AuthZoneStack, module_id = SELF, offset = AuthZoneStack(AuthZoneStack), flags = MUTABLE
[INFO] [stdout]     [1] Substate locked: handle = 48
[INFO] [stdout]     [1] Writing substate: handle = 48, size = 0
[INFO] [stdout]     [1] Dropping lock: handle = 48 
[INFO] [stdout] [0] Exiting: output size = 0
[INFO] [stdout] [0] Dropping node: id = AuthZoneStack
[INFO] [stdout] ---------------------------------Cost Analysis----------------------------------
[INFO] [stdout] CreateNode                    :      10000
[INFO] [stdout] DropLock                      :     105500
[INFO] [stdout] DropNode                      :       7500
[INFO] [stdout] Invoke                        :      11860
[INFO] [stdout] LockSubstate                  :     108000
[INFO] [stdout] ReadSubstate                  :      76920
[INFO] [stdout] RunNative                     :      72500
[INFO] [stdout] RunSystem                     :      12500
[INFO] [stdout] RunWasm                       :     541480
[INFO] [stdout] TxBaseCost                    :      50000
[INFO] [stdout] TxPayloadCost                 :        935
[INFO] [stdout] WriteSubstate                 :      27500
[INFO] [stdout] ----------------------------------Cost Totals-----------------------------------
[INFO] [stdout] Total Cost Units Consumed     :    1024695
[INFO] [stdout] Cost Unit Limit               :  100000000
[INFO] [stdout] Execution XRD                 :  0.1024695
[INFO] [stdout] Royalty XRD                   :          0
[INFO] [stdout] --------------------------------Application Logs--------------------------------
[INFO] [stdout] -------------------------------------Finish-------------------------------------
[INFO] [stdout] thread 'test_hello' panicked at /opt/rustwide/cargo-home/git/checkouts/radixdlt-scrypto-1833d92590086ce0/9d3787c/scrypto-unit/src/test_runner.rs:69:13:
[INFO] [stdout] Failed to compile package: "/opt/rustwide/workdir"
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x617f2e39d1aa - std::backtrace_rs::backtrace::libunwind::trace::h8810477743020387
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/../../backtrace/src/backtrace/libunwind.rs:116:5
[INFO] [stdout]    1:     0x617f2e39d1aa - std::backtrace_rs::backtrace::trace_unsynchronized::h3aa55355dd6c54a6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x617f2e39d1aa - std::sys::backtrace::_print_fmt::h8588b0f62410823f
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:66:9
[INFO] [stdout]    3:     0x617f2e39d1aa - <std::sys::backtrace::BacktraceLock::print::DisplayBacktrace as core::fmt::Display>::fmt::h98c26ac25ffe89bb
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:39:26
[INFO] [stdout]    4:     0x617f2e3c5523 - core::fmt::rt::Argument::fmt::hf95377f4aebd453b
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/fmt/rt.rs:177:76
[INFO] [stdout]    5:     0x617f2e3c5523 - core::fmt::write::h0dd5f6e2238c7982
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/fmt/mod.rs:1189:21
[INFO] [stdout]    6:     0x617f2e39a043 - std::io::Write::write_fmt::h03bb0ca26e6faf8c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/io/mod.rs:1884:15
[INFO] [stdout]    7:     0x617f2e39cff2 - std::sys::backtrace::BacktraceLock::print::h5c19c1c038ee186d
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:42:9
[INFO] [stdout]    8:     0x617f2e39e62d - std::panicking::default_hook::{{closure}}::h77172f079a1fcb13
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:268:22
[INFO] [stdout]    9:     0x617f2e39e437 - std::panicking::default_hook::he5f8e3b203ccddba
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:292:9
[INFO] [stdout]   10:     0x617f2d6c2477 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h7a3c7b4a1ae77f2f
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1986:9
[INFO] [stdout]   11:     0x617f2d6c2477 - test::test_main::{{closure}}::hf0d3b69ae9b353d1
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:134:21
[INFO] [stdout]   12:     0x617f2e39ecd8 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h6332e82e7b189abd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1986:9
[INFO] [stdout]   13:     0x617f2e39ecd8 - std::panicking::rust_panic_with_hook::h53863d4e9018df39
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:809:13
[INFO] [stdout]   14:     0x617f2e39ea9a - std::panicking::begin_panic_handler::{{closure}}::h67280e6fa0757873
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:674:13
[INFO] [stdout]   15:     0x617f2e39d689 - std::sys::backtrace::__rust_end_short_backtrace::h1dac3f54d6fbbeb2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:170:18
[INFO] [stdout]   16:     0x617f2e39e72c - rust_begin_unwind
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:665:5
[INFO] [stdout]   17:     0x617f2d685c20 - core::panicking::panic_fmt::h6792bd1b2bf01041
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panicking.rs:76:14
[INFO] [stdout]   18:     0x617f2d7e369f - scrypto_unit::test_runner::Compile::compile::h38996b14176be686
[INFO] [stdout]                                at /opt/rustwide/cargo-home/git/checkouts/radixdlt-scrypto-1833d92590086ce0/9d3787c/scrypto-unit/src/test_runner.rs:69:13
[INFO] [stdout]   19:     0x617f2d7e62d6 - scrypto_unit::test_runner::TestRunner::compile_and_publish::h693cdc1402d285da
[INFO] [stdout]                                at /opt/rustwide/cargo-home/git/checkouts/radixdlt-scrypto-1833d92590086ce0/9d3787c/scrypto-unit/src/test_runner.rs:589:30
[INFO] [stdout]   20:     0x617f2d6875fa - lib::test_hello::hd2cdc16d1284b0da
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/lib.rs:14:27
[INFO] [stdout]   21:     0x617f2d687497 - lib::test_hello::{{closure}}::hdb0051117a48ef01
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/lib.rs:6:16
[INFO] [stdout]   22:     0x617f2d686796 - core::ops::function::FnOnce::call_once::hda3db022408a0ec5
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   23:     0x617f2d6c6f9b - core::ops::function::FnOnce::call_once::h871bf86719ec9aa4
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x617f2d6c6f9b - test::__rust_begin_short_backtrace::h2167df1e2b7d76fd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:632:18
[INFO] [stdout]   25:     0x617f2d6c6988 - test::run_test_in_process::{{closure}}::h15d92f75a3adfb79
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:655:60
[INFO] [stdout]   26:     0x617f2d6c6988 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hb6c8955835a8dbbb
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   27:     0x617f2d6c6988 - std::panicking::try::do_call::hc79d0fc888a0bd30
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:557:40
[INFO] [stdout]   28:     0x617f2d6c6988 - std::panicking::try::hb8a7878e3a8589d6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:520:19
[INFO] [stdout]   29:     0x617f2d6c6988 - std::panic::catch_unwind::hb8e4600ff0ff5cfa
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panic.rs:358:14
[INFO] [stdout]   30:     0x617f2d6c6988 - test::run_test_in_process::hc2900b0b18688dd6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:655:27
[INFO] [stdout]   31:     0x617f2d6c6988 - test::run_test::{{closure}}::hac2a9cb07be3d48d
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:576:43
[INFO] [stdout]   32:     0x617f2d68a42a - test::run_test::{{closure}}::h4a5b729e66a38cd8
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:606:41
[INFO] [stdout]   33:     0x617f2d68a42a - std::sys::backtrace::__rust_begin_short_backtrace::h0496fb742492f573
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:154:18
[INFO] [stdout]   34:     0x617f2d68dda4 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hbb6d257c550a54bd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/mod.rs:561:17
[INFO] [stdout]   35:     0x617f2d68dda4 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h46696fe4a6832328
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   36:     0x617f2d68dda4 - std::panicking::try::do_call::h2625a51b667bfb64
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:557:40
[INFO] [stdout]   37:     0x617f2d68dda4 - std::panicking::try::hb956a59a1973aa4c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:520:19
[INFO] [stdout]   38:     0x617f2d68dda4 - std::panic::catch_unwind::h64f3b9d1067ef6a0
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panic.rs:358:14
[INFO] [stdout]   39:     0x617f2d68dda4 - std::thread::Builder::spawn_unchecked_::{{closure}}::h42b2841295b6c0b2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/mod.rs:559:30
[INFO] [stdout]   40:     0x617f2d68dda4 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h6127de71b8124639
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   41:     0x617f2e3a2e1b - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h42f0ba71002a1b2c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1972:9
[INFO] [stdout]   42:     0x617f2e3a2e1b - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::had9e47d7a3dcecb8
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1972:9
[INFO] [stdout]   43:     0x617f2e3a2e1b - std::sys::pal::unix::thread::Thread::new::thread_start::h48cf765408f6f5f2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/pal/unix/thread.rs:105:17
[INFO] [stdout]   44:     0x788cbc149ac3 - <unknown>
[INFO] [stdout]   45:     0x788cbc1daa04 - clone
[INFO] [stdout]   46:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     test_hello
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 0 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 8.15s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--test lib`
[INFO] running `Command { std: "docker" "inspect" "ad509dff2bd2e5f37e1132e193a377bcd87b029e6c7351741905e13082fd3dc4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ad509dff2bd2e5f37e1132e193a377bcd87b029e6c7351741905e13082fd3dc4", kill_on_drop: false }`
[INFO] [stdout] ad509dff2bd2e5f37e1132e193a377bcd87b029e6c7351741905e13082fd3dc4
