Date: Sun, 11 Jun 2023 00:57:16 +0000
Subject: [PATCH 27/89] Working on fixes
---
examples/tokenvm/go.mod | 3 +-
examples/tokenvm/go.sum | 7 +
examples/tokenvm/test.log | 1867 ++++++++++++++++++++++++++++++++++++
examples/tokenvm/test2.log | 1662 ++++++++++++++++++++++++++++++++
4 files changed, 3538 insertions(+), 1 deletion(-)
create mode 100644 examples/tokenvm/test.log
create mode 100644 examples/tokenvm/test2.log
diff --git a/examples/tokenvm/go.mod b/examples/tokenvm/go.mod
index ada1161111..e8a00b5290 100644
--- a/examples/tokenvm/go.mod
+++ b/examples/tokenvm/go.mod
@@ -3,9 +3,9 @@ module github.com/AnomalyFi/hypersdk/examples/tokenvm
go 1.20
require (
+ github.com/AnomalyFi/hypersdk v0.2.0
github.com/ava-labs/avalanche-network-runner v1.4.1
github.com/ava-labs/avalanchego v1.10.1
- github.com/AnomalyFi/hypersdk v0.2.0
github.com/fatih/color v1.13.0
github.com/manifoldco/promptui v0.9.0
github.com/onsi/ginkgo/v2 v2.7.0
@@ -106,6 +106,7 @@ require (
github.com/spf13/pflag v1.0.5 // indirect
github.com/spf13/viper v1.12.0 // indirect
github.com/status-im/keycard-go v0.0.0-20200402102358-957c09536969 // indirect
+ github.com/stretchr/objx v0.5.0 // indirect
github.com/stretchr/testify v1.8.2 // indirect
github.com/subosito/gotenv v1.3.0 // indirect
github.com/supranational/blst v0.3.11-0.20220920110316-f72618070295 // indirect
diff --git a/examples/tokenvm/go.sum b/examples/tokenvm/go.sum
index 1122b98ffd..b91a6ef3d8 100644
--- a/examples/tokenvm/go.sum
+++ b/examples/tokenvm/go.sum
@@ -101,6 +101,8 @@ github.com/btcsuite/snappy-go v0.0.0-20151229074030-0bdef8d06723/go.mod h1:8woku
github.com/btcsuite/snappy-go v1.0.0/go.mod h1:8woku9dyThutzjeg+3xrA5iCpBRH8XEEg3lh6TiUghc=
github.com/btcsuite/websocket v0.0.0-20150119174127-31079b680792/go.mod h1:ghJtEyQwv5/p4Mg4C0fgbePVuGr935/5ddU9Z3TmDRY=
github.com/btcsuite/winsvc v1.0.0/go.mod h1:jsenWakMcC0zFBFurPLEAyrnc/teJEM1O46fmI40EZs=
+github.com/celestiaorg/go-cnc v0.4.1 h1:7fz8Y8HKKxE2dCp2m9Qlm+NoROxJWGCiKtcvaYp8iM8=
+github.com/celestiaorg/go-cnc v0.4.1/go.mod h1:zYzvHudSd1iNPuHBMyvZ1YvWou5aT9JXgtch9Tkaf70=
github.com/cenkalti/backoff/v4 v4.2.0 h1:HN5dHm3WBOgndBH6E8V0q2jIYIR3s9yglV8k/+MN3u4=
github.com/cenkalti/backoff/v4 v4.2.0/go.mod h1:Y3VNntkOUPxTVeUxJ/G5vcM//AlwfmyYozVcomhLiZE=
github.com/census-instrumentation/opencensus-proto v0.2.1/go.mod h1:f6KPmirojxKA12rnyqOA5BBL4O983OfeGPqjHWSTneU=
@@ -219,6 +221,8 @@ github.com/go-logr/stdr v1.2.2/go.mod h1:mMo/vtBO5dYbehREoey6XUKy/eSumjCCveDpRre
github.com/go-martini/martini v0.0.0-20170121215854-22fa46961aab/go.mod h1:/P9AEU963A2AYjv4d1V5eVL1CQbEJq6aCNHDDjibzu8=
github.com/go-ole/go-ole v1.2.6 h1:/Fpf6oFPoeFik9ty7siob0G6Ke8QvQEuVcuChpwXzpY=
github.com/go-ole/go-ole v1.2.6/go.mod h1:pprOEPIfldk/42T2oK7lQ4v4JSDwmV0As9GaiUsvbm0=
+github.com/go-resty/resty/v2 v2.7.0 h1:me+K9p3uhSmXtrBZ4k9jcEAfJmuC8IivWHwaLZwPrFY=
+github.com/go-resty/resty/v2 v2.7.0/go.mod h1:9PWDzw47qPphMRFfhsyk0NnSgvluHcljSMVIq3w7q0I=
github.com/go-sourcemap/sourcemap v2.1.3+incompatible h1:W1iEw64niKVGogNgBN3ePyLFfuisuzeidWPMPWmECqU=
github.com/go-sourcemap/sourcemap v2.1.3+incompatible/go.mod h1:F8jJfvm2KbVjc5NqelyYJmf/v5J0dwNLS2mL4sNA1Jg=
github.com/go-stack/stack v1.8.0 h1:5SgMzNM5HxrEjV0ww2lTmX6E2Izsfxas4+YHWRs3Lsk=
@@ -588,6 +592,8 @@ github.com/stretchr/testify v1.7.2/go.mod h1:R6va5+xMeoiuVRoj+gSkQ7d3FALtqAAGI1F
github.com/stretchr/testify v1.8.0/go.mod h1:yNjHg4UonilssWZ8iaSj1OCr/vHnekPRkoO+kdMU+MU=
github.com/stretchr/testify v1.8.1 h1:w7B6lhMri9wdJUVmEZPGGhZzrYTPvgJArz7wNPgYKsk=
github.com/stretchr/testify v1.8.1/go.mod h1:w2LPCIKwWwSfY2zedu0+kehJoqGctiVI29o6fzry7u4=
+github.com/stretchr/testify v1.8.2 h1:+h33VjcLVPDHtOdpUCuF+7gSuG3yGIftsP1YvFihtJ8=
+github.com/stretchr/testify v1.8.2/go.mod h1:w2LPCIKwWwSfY2zedu0+kehJoqGctiVI29o6fzry7u4=
github.com/subosito/gotenv v1.3.0 h1:mjC+YW8QpAdXibNi+vNWgzmgBH4+5l5dCXv8cNysBLI=
github.com/subosito/gotenv v1.3.0/go.mod h1:YzJjq/33h7nrwdY+iHMhEOEEbW0ovIz0tB6t6PwAXzs=
github.com/supranational/blst v0.3.11-0.20220920110316-f72618070295 h1:rVKS9JjtqE4/PscoIsP46sRnJhfq8YFbjlk0fUJTRnY=
@@ -750,6 +756,7 @@ golang.org/x/net v0.0.0-20210226172049-e18ecbb05110/go.mod h1:m0MpNAwzfU5UDzcl9v
golang.org/x/net v0.0.0-20210405180319-a5a99cb37ef4/go.mod h1:p54w0d4576C0XHj96bSt6lcn1PtDYWL6XObtHCRCNQM=
golang.org/x/net v0.0.0-20210428140749-89ef3d95e781/go.mod h1:OJAsFXCWl8Ukc7SiCT/9KSuxbyM7479/AVlXFRxuMCk=
golang.org/x/net v0.0.0-20210525063256-abc453219eb5/go.mod h1:9nx3DQGgdP8bBQD5qxJ1jj9UTztislL4KSBs9R2vV5Y=
+golang.org/x/net v0.0.0-20211029224645-99673261e6eb/go.mod h1:9nx3DQGgdP8bBQD5qxJ1jj9UTztislL4KSBs9R2vV5Y=
golang.org/x/net v0.0.0-20220127200216-cd36cc0744dd/go.mod h1:CfG3xpIq0wQ8r1q4Su4UZFWDARRcnwPjda9FqA0JpMk=
golang.org/x/net v0.0.0-20220225172249-27dd8689420f/go.mod h1:CfG3xpIq0wQ8r1q4Su4UZFWDARRcnwPjda9FqA0JpMk=
golang.org/x/net v0.0.0-20220607020251-c690dde0001d/go.mod h1:XRhObCWvk6IyKnWLug+ECip1KBveYUHfp+8e9klMJ9c=
diff --git a/examples/tokenvm/test.log b/examples/tokenvm/test.log
new file mode 100644
index 0000000000..6af38e7154
--- /dev/null
+++ b/examples/tokenvm/test.log
@@ -0,0 +1,1867 @@
+Running with:
+VERSION: 1.10.1
+MODE: run-single
+STATESYNC_DELAY: 0
+PROPOSER_MIN_BLOCK_DELAY: 0
+using previously built avalanchego
+building tokenvm
+building token-cli
+/tmp/avalanchego-v1.10.1
+/tmp/avalanchego-v1.10.1/avalanchego
+/tmp/avalanchego-v1.10.1/plugins
+/tmp/avalanchego-v1.10.1/plugins/tHBYNu8ikqo4MWMHehC9iKB9mR5tB3DWzbkYmTfe9buWQ5GZ8
+creating allocations file
+creating VM genesis file with allocations
+[38;5;11mdatabase:[0m .token-cli
+created genesis and saved to /tmp/tokenvm.genesis
+creating vm config
+creating subnet config
+building e2e.test
+Compiled e2e.test
+launch avalanche-network-runner in the background
+running e2e tests
+[06-11|00:50:34.254] INFO server/server.go:169 dialing gRPC server for gRPC gateway {"port": ":12352"}
+[06-11|00:50:34.254] INFO server/server.go:159 serving gRPC server {"port": ":12352"}
+[06-11|00:50:34.257] INFO server/server.go:193 serving gRPC gateway {"port": ":12353"}
+[38;5;11mskipping tests[0m
+Running Suite: tokenvm e2e test suites - /home/anomalyfi/code/hypersdk/examples/tokenvm
+=======================================================================================
+Random Seed: [1m1686444634[0m
+
+Will run [1m4[0m of [1m4[0m specs
+[38;5;243m------------------------------[0m
+[0m[1m[BeforeSuite] [0m
+[38;5;243m/home/anomalyfi/code/hypersdk/examples/tokenvm/tests/e2e/e2e_test.go:157[0m
+[06-11|00:50:34.325] DEBUG client/client.go:70 dialing server at {"endpoint": "0.0.0.0:12352"}
+[38;5;10msending 'start' with binary path:[0m "/tmp/avalanchego-v1.10.1/avalanchego" ("tHBYNu8ikqo4MWMHehC9iKB9mR5tB3DWzbkYmTfe9buWQ5GZ8")
+[06-11|00:50:34.327] INFO client/client.go:139 start
+[06-11|00:50:34.328] INFO server/server.go:340 starting {"exec-path": "/tmp/avalanchego-v1.10.1/avalanchego", "num-nodes": 5, "track-subnets": "", "pid": 514258, "root-data-dir": "/tmp/network-runner-root-data_20230611_005034", "plugin-dir": "/tmp/avalanchego-v1.10.1/plugins", "chain-configs": null, "global-node-config": "{\n\t\t\t\t\"log-display-level\":\"info\",\n\t\t\t\t\"proposervm-use-current-height\":true,\n\t\t\t\t\"throttler-inbound-validator-alloc-size\":\"10737418240\",\n\t\t\t\t\"throttler-inbound-at-large-alloc-size\":\"10737418240\",\n\t\t\t\t\"throttler-inbound-node-max-processing-msgs\":\"100000\",\n\t\t\t\t\"throttler-inbound-bandwidth-refill-rate\":\"1073741824\",\n\t\t\t\t\"throttler-inbound-bandwidth-max-burst-size\":\"1073741824\",\n\t\t\t\t\"throttler-inbound-cpu-validator-alloc\":\"100000\",\n\t\t\t\t\"throttler-inbound-disk-validator-alloc\":\"10737418240000\",\n\t\t\t\t\"throttler-outbound-validator-alloc-size\":\"10737418240\",\n\t\t\t\t\"throttler-outbound-at-large-alloc-size\":\"10737418240\",\n\t\t\t\t\"snow-mixed-query-num-push-vdr\":\"10\",\n\t\t\t\t\"consensus-on-accept-gossip-validator-size\":\"10\",\n\t\t\t\t\"consensus-on-accept-gossip-peer-size\":\"10\",\n\t\t\t\t\"network-compression-type\":\"none\",\n\t\t\t\t\"consensus-app-concurrency\":\"512\"\n\t\t\t}"}
+[06-11|00:50:34.329] INFO ux/output.go:13 [0;34m[;1mcreate and run local network[0;0m[0;0m
+[06-11|00:50:34.329] INFO local/network.go:419 creating network {"node-num": 5}
+[06-11|00:50:34.728] INFO local/network.go:587 adding node {"node-name": "node1", "node-dir": "/tmp/network-runner-root-data_20230611_005034/node1", "log-dir": "/tmp/network-runner-root-data_20230611_005034/node1/logs", "db-dir": "/tmp/network-runner-root-data_20230611_005034/node1/db", "p2p-port": 9651, "api-port": 9650}
+[06-11|00:50:34.728] DEBUG local/network.go:597 starting node {"name": "node1", "binaryPath": "/tmp/avalanchego-v1.10.1/avalanchego", "args": ["--network-max-reconnect-delay=1s", "--staking-tls-key-file=/tmp/network-runner-root-data_20230611_005034/node1/staking.key", "--proposervm-use-current-height=true", "--consensus-on-accept-gossip-peer-size=10", "--throttler-inbound-at-large-alloc-size=10737418240", "--log-dir=/tmp/network-runner-root-data_20230611_005034/node1/logs", "--throttler-inbound-validator-alloc-size=10737418240", "--staking-port=9651", "--genesis=/tmp/network-runner-root-data_20230611_005034/node1/genesis.json", "--chain-config-dir=/tmp/network-runner-root-data_20230611_005034/node1/chainConfigs", "--subnet-config-dir=/tmp/network-runner-root-data_20230611_005034/node1/subnetConfigs", "--index-enabled=true", "--db-dir=/tmp/network-runner-root-data_20230611_005034/node1/db", "--http-port=9650", "--throttler-inbound-disk-validator-alloc=10737418240000", "--consensus-on-accept-gossip-validator-size=10", "--plugin-dir=/tmp/avalanchego-v1.10.1/plugins", "--throttler-inbound-cpu-validator-alloc=100000", "--bootstrap-ids=", "--bootstrap-ips=", "--public-ip=127.0.0.1", "--network-compression-type=none", "--staking-tls-cert-file=/tmp/network-runner-root-data_20230611_005034/node1/staking.crt", "--throttler-inbound-bandwidth-max-burst-size=1073741824", "--throttler-inbound-bandwidth-refill-rate=1073741824", "--api-ipcs-enabled=true", "--throttler-outbound-validator-alloc-size=10737418240", "--network-peer-list-gossip-frequency=250ms", "--staking-signer-key-file=/tmp/network-runner-root-data_20230611_005034/node1/signer.key", "--data-dir=/tmp/network-runner-root-data_20230611_005034/node1", "--snow-mixed-query-num-push-vdr=10", "--consensus-app-concurrency=512", "--log-level=DEBUG", "--network-id=1337", "--throttler-inbound-node-max-processing-msgs=100000", "--throttler-outbound-at-large-alloc-size=10737418240", "--health-check-frequency=2s", "--api-admin-enabled=true", "--log-display-level=info"]}
+[06-11|00:50:35.065] INFO local/network.go:587 adding node {"node-name": "node2", "node-dir": "/tmp/network-runner-root-data_20230611_005034/node2", "log-dir": "/tmp/network-runner-root-data_20230611_005034/node2/logs", "db-dir": "/tmp/network-runner-root-data_20230611_005034/node2/db", "p2p-port": 9653, "api-port": 9652}
+[06-11|00:50:35.066] DEBUG local/network.go:597 starting node {"name": "node2", "binaryPath": "/tmp/avalanchego-v1.10.1/avalanchego", "args": ["--consensus-app-concurrency=512", "--network-peer-list-gossip-frequency=250ms", "--db-dir=/tmp/network-runner-root-data_20230611_005034/node2/db", "--staking-port=9653", "--network-max-reconnect-delay=1s", "--health-check-frequency=2s", "--api-ipcs-enabled=true", "--chain-config-dir=/tmp/network-runner-root-data_20230611_005034/node2/chainConfigs", "--consensus-on-accept-gossip-peer-size=10", "--api-admin-enabled=true", "--public-ip=127.0.0.1", "--http-port=9652", "--staking-signer-key-file=/tmp/network-runner-root-data_20230611_005034/node2/signer.key", "--staking-tls-key-file=/tmp/network-runner-root-data_20230611_005034/node2/staking.key", "--subnet-config-dir=/tmp/network-runner-root-data_20230611_005034/node2/subnetConfigs", "--snow-mixed-query-num-push-vdr=10", "--log-display-level=info", "--consensus-on-accept-gossip-validator-size=10", "--staking-tls-cert-file=/tmp/network-runner-root-data_20230611_005034/node2/staking.crt", "--bootstrap-ids=NodeID-7Xhw2mDxuDS44j42TCB6U5579esbSt3Lg", "--throttler-inbound-cpu-validator-alloc=100000", "--network-id=1337", "--network-compression-type=none", "--bootstrap-ips=[::1]:9651", "--throttler-inbound-bandwidth-refill-rate=1073741824", "--log-level=DEBUG", "--log-dir=/tmp/network-runner-root-data_20230611_005034/node2/logs", "--throttler-inbound-node-max-processing-msgs=100000", "--throttler-inbound-validator-alloc-size=10737418240", "--throttler-inbound-at-large-alloc-size=10737418240", "--throttler-inbound-bandwidth-max-burst-size=1073741824", "--proposervm-use-current-height=true", "--throttler-outbound-validator-alloc-size=10737418240", "--plugin-dir=/tmp/avalanchego-v1.10.1/plugins", "--throttler-inbound-disk-validator-alloc=10737418240000", "--index-enabled=true", "--genesis=/tmp/network-runner-root-data_20230611_005034/node2/genesis.json", "--data-dir=/tmp/network-runner-root-data_20230611_005034/node2", "--throttler-outbound-at-large-alloc-size=10737418240"]}
+[0;36m[node1] [06-11|00:50:35.116] WARN app/app.go:153 P2P IP is private, you will not be publicly discoverable {"ip": "127.0.0.1"}
+[0;0m[0;36m[node1] [06-11|00:50:35.117] INFO node/node.go:1251 initializing node {"version": "avalanche/1.10.1", "nodeID": "NodeID-7Xhw2mDxuDS44j42TCB6U5579esbSt3Lg", "nodePOP": {"publicKey":"0xb3ebbe748a1f06d19ee25d4e345ba8d6b5a426498a140c2519b518e3e6224abd7895075892f361acf24c10af968bc7de","proofOfPossession":"0xa2569a137e65d3a507c4f1f7ffac74ec05916ba44dfbbb84d42c2736a2bc1e8be14038d3aeeeac7c78e19ecdde69d830051959f22559641a3f9e42377d7f64580acdc383c5c9e22f7f1114712a543c6997d6dc59c88555423497d9fff41fa79a"}, "providedFlags": {"api-admin-enabled":true,"api-ipcs-enabled":true,"bootstrap-ids":"","bootstrap-ips":"","chain-config-dir":"/tmp/network-runner-root-data_20230611_005034/node1/chainConfigs","consensus-app-concurrency":"512","consensus-on-accept-gossip-peer-size":"10","consensus-on-accept-gossip-validator-size":"10","data-dir":"/tmp/network-runner-root-data_20230611_005034/node1","db-dir":"/tmp/network-runner-root-data_20230611_005034/node1/db","genesis":"/tmp/network-runner-root-data_20230611_005034/node1/genesis.json","health-check-frequency":"2s","http-port":"9650","index-enabled":true,"log-dir":"/tmp/network-runner-root-data_20230611_005034/node1/logs","log-display-level":"info","log-level":"DEBUG","network-compression-type":"none","network-id":"1337","network-max-reconnect-delay":"1s","network-peer-list-gossip-frequency":"250ms","plugin-dir":"/tmp/avalanchego-v1.10.1/plugins","proposervm-use-current-height":true,"public-ip":"127.0.0.1","snow-mixed-query-num-push-vdr":"10","staking-port":"9651","staking-signer-key-file":"/tmp/network-runner-root-data_20230611_005034/node1/signer.key","staking-tls-cert-file":"/tmp/network-runner-root-data_20230611_005034/node1/staking.crt","staking-tls-key-file":"/tmp/network-runner-root-data_20230611_005034/node1/staking.key","subnet-config-dir":"/tmp/network-runner-root-data_20230611_005034/node1/subnetConfigs","throttler-inbound-at-large-alloc-size":"10737418240","throttler-inbound-bandwidth-max-burst-size":"1073741824","throttler-inbound-bandwidth-refill-rate":"1073741824","throttler-inbound-cpu-validator-alloc":"100000","throttler-inbound-disk-validator-alloc":"1.073741824e+13","throttler-inbound-node-max-processing-msgs":"100000","throttler-inbound-validator-alloc-size":"10737418240","throttler-outbound-at-large-alloc-size":"10737418240","throttler-outbound-validator-alloc-size":"10737418240"}, "config": {"httpConfig":{"readTimeout":30000000000,"readHeaderTimeout":30000000000,"writeHeaderTimeout":30000000000,"idleTimeout":120000000000,"apiConfig":{"authConfig":{"apiRequireAuthToken":false},"indexerConfig":{"indexAPIEnabled":true,"indexAllowIncomplete":false},"ipcConfig":{"ipcAPIEnabled":true,"ipcPath":"/tmp","ipcDefaultChainIDs":null},"adminAPIEnabled":true,"infoAPIEnabled":true,"keystoreAPIEnabled":false,"metricsAPIEnabled":true,"healthAPIEnabled":true},"httpHost":"127.0.0.1","httpPort":9650,"httpsEnabled":false,"apiAllowedOrigins":["*"],"shutdownTimeout":10000000000,"shutdownWait":0},"ipConfig":{"ip":{"ip":"127.0.0.1","port":9651},"ipResolutionFrequency":300000000000,"attemptedNATTraversal":false},"stakingConfig":{"uptimeRequirement":0.8,"minValidatorStake":2000000000000,"maxValidatorStake":3000000000000000,"minDelegatorStake":25000000000,"minDelegationFee":20000,"minStakeDuration":86400000000000,"maxStakeDuration":31536000000000000,"rewardConfig":{"maxConsumptionRate":120000,"minConsumptionRate":100000,"mintingPeriod":31536000000000000,"supplyCap":720000000000000000},"enableStaking":true,"disabledStakingWeight":100,"stakingKeyPath":"/tmp/network-runner-root-data_20230611_005034/node1/staking.key","stakingCertPath":"/tmp/network-runner-root-data_20230611_005034/node1/staking.crt","stakingSignerPath":"/tmp/network-runner-root-data_20230611_005034/node1/signer.key"},"txFeeConfig":{"txFee":1000000,"createAssetTxFee":1000000,"createSubnetTxFee":100000000,"transformSubnetTxFee":100000000,"createBlockchainTxFee":100000000,"addPrimaryNetworkValidatorFee":0,"addPrimaryNetworkDelegatorFee":0,"addSubnetValidatorFee":1000000,"addSubnetDelegatorFee":1000000},"stateSyncConfig":{"stateSyncIDs":null,"stateSyncIPs":null},"bootstrapConfig":{"retryBootstrap":true,"retryBootstrapWarnFrequency":50,"bootstrapBeaconConnectionTimeout":60000000000,"bootstrapAncestorsMaxContainersSent":2000,"bootstrapAncestorsMaxContainersReceived":2000,"bootstrapMaxTimeGetAncestors":50000000,"bootstrapIDs":null,"bootstrapIPs":null},"databaseConfig":{"path":"/tmp/network-runner-root-data_20230611_005034/node1/db/network-1337","name":"leveldb"},"avaxAssetID":"BUuypiq2wyuLMvyhzFXcPyxPMCgSp7eeDohhQRqTChoBjKziC","networkID":1337,"healthCheckFreq":2000000000,"networkConfig":{"healthConfig":{"minConnectedPeers":1,"maxTimeSinceMsgReceived":60000000000,"maxTimeSinceMsgSent":60000000000,"maxPortionSendQueueBytesFull":0.9,"maxSendFailRate":0.9,"sendFailRateHalflife":10000000000},"peerListGossipConfig":{"peerListNumValidatorIPs":15,"peerListValidatorGossipSize":20,"peerListNonValidatorGossipSize":0,"peerListPeersGossipSize":10,"peerListGossipFreq":250000000},"timeoutConfigs":{"pingPongTimeout":30000000000,"readHandshakeTimeout":15000000000},"delayConfig":{"initialReconnectDelay":1000000000,"maxReconnectDelay":1000000000},"throttlerConfig":{"inboundConnUpgradeThrottlerConfig":{"upgradeCooldown":10000000000,"maxRecentConnsUpgraded":2560},"inboundMsgThrottlerConfig":{"byteThrottlerConfig":{"vdrAllocSize":10737418240,"atLargeAllocSize":10737418240,"nodeMaxAtLargeBytes":2097152},"bandwidthThrottlerConfig":{"bandwidthRefillRate":1073741824,"bandwidthMaxBurstRate":1073741824},"cpuThrottlerConfig":{"maxRecheckDelay":5000000000},"diskThrottlerConfig":{"maxRecheckDelay":5000000000},"maxProcessingMsgsPerNode":100000},"outboundMsgThrottlerConfig":{"vdrAllocSize":10737418240,"atLargeAllocSize":10737418240,"nodeMaxAtLargeBytes":2097152},"maxInboundConnsPerSec":256},"proxyEnabled":false,"proxyReadHeaderTimeout":3000000000,"dialerConfig":{"throttleRps":50,"connectionTimeout":30000000000},"tlsKeyLogFile":"","namespace":"","myNodeID":"NodeID-111111111111111111116DBWJs","myIP":null,"networkID":0,"maxClockDifference":60000000000,"pingFrequency":22500000000,"allowPrivateIPs":true,"compressionType":"none","uptimeMetricFreq":30000000000,"requireValidatorToConnect":false,"maximumInboundMessageTimeout":10000000000,"peerReadBufferSize":8192,"peerWriteBufferSize":8192},"adaptiveTimeoutConfig":{"initialTimeout":5000000000,"minimumTimeout":2000000000,"maximumTimeout":10000000000,"timeoutCoefficient":2,"timeoutHalflife":300000000000},"benchlistConfig":{"threshold":10,"minimumFailingDuration":150000000000,"duration":900000000000,"maxPortion":0.08333333333333333},"profilerConfig":{"dir":"/tmp/network-runner-root-data_20230611_005034/node1/profiles","enabled":false,"freq":900000000000,"maxNumFiles":5},"loggingConfig":{"maxSize":8,"maxFiles":7,"maxAge":0,"directory":"/tmp/network-runner-root-data_20230611_005034/node1/logs","compress":false,"disableWriterDisplaying":false,"logLevel":"DEBUG","displayLevel":"INFO","logFormat":"PLAIN"},"pluginDir":"/tmp/avalanchego-v1.10.1/plugins","fdLimit":32768,"meterVMEnabled":true,"routerHealthConfig":{"maxDropRate":1,"maxDropRateHalflife":10000000000,"maxOutstandingRequests":1024,"maxOutstandingDuration":300000000000,"maxRunTimeRequests":10000000000},"consensusShutdownTimeout":30000000000,"consensusGossipFreq":10000000000,"consensusAppConcurrency":512,"trackedSubnets":[],"subnetConfigs":{"11111111111111111111111111111111LpoYY":{"gossipAcceptedFrontierValidatorSize":0,"gossipAcceptedFrontierNonValidatorSize":0,"gossipAcceptedFrontierPeerSize":15,"gossipOnAcceptValidatorSize":10,"gossipOnAcceptNonValidatorSize":0,"gossipOnAcceptPeerSize":10,"appGossipValidatorSize":10,"appGossipNonValidatorSize":0,"appGossipPeerSize":0,"validatorOnly":false,"allowedNodes":null,"consensusParameters":{"k":20,"alpha":15,"betaVirtuous":20,"betaRogue":20,"concurrentRepolls":4,"optimalProcessing":10,"maxOutstandingItems":256,"maxItemProcessingTime":30000000000,"mixedQueryNumPushVdr":10,"mixedQueryNumPushNonVdr":0},"proposerMinBlockDelay":1000000000,"minPercentConnectedStakeHealthy":0}},"chainAliases":null,"systemTrackerProcessingHalflife":15000000000,"systemTrackerFrequency":500000000,"systemTrackerCPUHalflife":15000000000,"systemTrackerDiskHalflife":60000000000,"cpuTargeterConfig":{"vdrAlloc":100000,"maxNonVdrUsage":44.800000000000004,"maxNonVdrNodeUsage":7},"diskTargeterConfig":{"vdrAlloc":10737418240000,"maxNonVdrUsage":1073741824000,"maxNonVdrNodeUsage":1073741824000},"requiredAvailableDiskSpace":536870912,"warningThresholdAvailableDiskSpace":1073741824,"traceConfig":{"exporterConfig":{"type":"unknown","endpoint":"","headers":null,"insecure":false},"enabled":false,"traceSampleRate":0},"minPercentConnectedStakeHealthy":{"11111111111111111111111111111111LpoYY":0.8},"useCurrentHeight":true,"chainDataDir":"/tmp/network-runner-root-data_20230611_005034/node1/chainData"}}
+[0;0m[0;36m[node1] [06-11|00:50:35.118] INFO node/node.go:582 initializing API server
+[0;0m[0;36m[node1] [06-11|00:50:35.118] INFO server/server.go:147 API created {"allowedOrigins": ["*"]}
+[0;0m[0;36m[node1] [06-11|00:50:35.118] INFO node/node.go:912 initializing metrics API
+[0;0m[0;36m[node1] [06-11|00:50:35.118] INFO server/server.go:308 adding route {"url": "/ext/metrics", "endpoint": ""}
+[0;0m[0;36m[node1] [06-11|00:50:35.118] INFO leveldb/db.go:208 creating leveldb {"config": {"blockCacheCapacity":12582912,"blockSize":0,"compactionExpandLimitFactor":0,"compactionGPOverlapsFactor":0,"compactionL0Trigger":0,"compactionSourceLimitFactor":0,"compactionTableSize":0,"compactionTableSizeMultiplier":0,"compactionTableSizeMultiplierPerLevel":null,"compactionTotalSize":0,"compactionTotalSizeMultiplier":0,"disableSeeksCompaction":true,"openFilesCacheCapacity":1024,"writeBuffer":6291456,"filterBitsPerKey":10,"maxManifestFileSize":9223372036854775807,"metricUpdateFrequency":10000000000}}
+[0;0m[0;36m[node1] [06-11|00:50:35.147] INFO node/node.go:452 initializing database {"dbVersion": "v1.4.5"}
+[0;0m[0;36m[node1] [06-11|00:50:35.148] INFO node/node.go:869 initializing keystore
+[0;0m[0;36m[node1] [06-11|00:50:35.148] INFO node/node.go:877 skipping keystore API initialization because it has been disabled
+[0;0m[0;36m[node1] [06-11|00:50:35.148] INFO node/node.go:861 initializing SharedMemory
+[0;0m[0;36m[node1] [06-11|00:50:35.169] INFO node/node.go:232 initializing networking {"currentNodeIP": "127.0.0.1:9651"}
+[0;0m[0;36m[node1] [06-11|00:50:35.171] INFO node/node.go:1032 initializing Health API
+[0;0m[0;36m[node1] [06-11|00:50:35.171] INFO server/server.go:308 adding route {"url": "/ext/health", "endpoint": ""}
+[0;0m[0;36m[node1] [06-11|00:50:35.171] INFO server/server.go:308 adding route {"url": "/ext/health", "endpoint": "/readiness"}
+[0;0m[0;36m[node1] [06-11|00:50:35.171] INFO server/server.go:308 adding route {"url": "/ext/health", "endpoint": "/health"}
+[0;0m[0;36m[node1] [06-11|00:50:35.171] INFO server/server.go:308 adding route {"url": "/ext/health", "endpoint": "/liveness"}
+[0;0m[0;36m[node1] [06-11|00:50:35.171] INFO node/node.go:642 adding the default VM aliases
+[0;0m[0;36m[node1] [06-11|00:50:35.171] INFO node/node.go:763 initializing VMs
+[0;0m[0;36m[node1] [06-11|00:50:35.171] INFO server/server.go:308 adding route {"url": "/ext/vm/rWhpuQPF1kb72esV2momhMuTYGkEb1oL29pt2EBXWmSy4kxnT", "endpoint": ""}
+[0;0m[0;36m[node1] [06-11|00:50:35.171] INFO server/server.go:308 adding route {"url": "/ext/vm/jvYyfQTxGMJLuGWa55kdP2p2zSUYsQ5Raupu4TW34ZAUBAbtq", "endpoint": ""}
+[0;0m[0;36m[node1] [06-11|00:50:35.171] INFO server/server.go:308 adding route {"url": "/ext/vm/mgj786NP7uDwBCcq6YwThhaN8FLyybkCa4zBWTQbNgmK6k9A6", "endpoint": "/rpc"}
+[0;0m[0;36m[node1] [06-11|00:50:35.246] INFO subprocess/runtime.go:143 plugin handshake succeeded {"addr": "127.0.0.1:46325"}
+[0;0m[0;36m[node1] runtime engine: received shutdown signal: SIGTERM
+[0;0m[0;36m[node1] vm server: graceful termination success
+[0;0m[0;36m[node1] [06-11|00:50:35.253] INFO subprocess/runtime.go:111 stdout collector shutdown
+[0;0m[0;36m[node1] [06-11|00:50:35.253] INFO subprocess/runtime.go:124 stderr collector shutdown
+[0;0m[0;36m[node1] [06-11|00:50:35.322] INFO subprocess/runtime.go:143 plugin handshake succeeded {"addr": "127.0.0.1:33491"}
+[0;0m[0;36m[node1] [06-11|00:50:35.324] INFO node/node.go:935 initializing admin API
+[0;0m[0;36m[node1] [06-11|00:50:35.324] INFO server/server.go:308 adding route {"url": "/ext/admin", "endpoint": ""}
+[0;0m[0;36m[node1] [06-11|00:50:35.324] INFO node/node.go:984 initializing info API
+[0;0m[0;36m[node1] [06-11|00:50:35.327] INFO server/server.go:308 adding route {"url": "/ext/info", "endpoint": ""}
+[0;0m[0;36m[node1] [06-11|00:50:35.327] WARN node/node.go:1138 initializing deprecated ipc API
+[0;0m[0;36m[node1] [06-11|00:50:35.327] INFO server/server.go:308 adding route {"url": "/ext/ipcs", "endpoint": ""}
+[0;0m[0;36m[node1] [06-11|00:50:35.327] INFO node/node.go:1148 initializing chain aliases
+[0;0m[0;36m[node1] [06-11|00:50:35.327] INFO node/node.go:1175 initializing API aliases
+[0;0m[0;36m[node1] [06-11|00:50:35.328] INFO node/node.go:957 skipping profiler initialization because it has been disabled
+[0;0m[0;36m[node1] [06-11|00:50:35.328] INFO node/node.go:561 initializing chains
+[0;0m[0;36m[node1] [06-11|00:50:35.328] INFO chains/manager.go:319 creating chain {"subnetID": "11111111111111111111111111111111LpoYY", "chainID": "11111111111111111111111111111111LpoYY", "vmID": "rWhpuQPF1kb72esV2momhMuTYGkEb1oL29pt2EBXWmSy4kxnT"}
+[0;0m[0;36m[node1] [06-11|00:50:35.330] INFO chains/manager.go:1102 creating proposervm wrapper {"activationTime": "[12-05|05:00:00.000]", "minPChainHeight": 0, "minBlockDelay": "1s"}
+[0;0m[0;36m[node1] [06-11|00:50:35.333] INFO platformvm/vm.go:228 initializing last accepted {"blkID": "2EYLCg5YdYRx9h3g3odqDB49o35ekw6NtXqJaom7pb3Rpvmonc"}
+[0;0m[0;36m[node1] [06-11|00:50:35.336] INFO
snowman/transitive.go:89 initializing consensus engine
+[0;0m[0;36m[node1] [06-11|00:50:35.337] INFO server/server.go:269 adding route {"url": "/ext/bc/11111111111111111111111111111111LpoYY", "endpoint": ""}
+[0;0m[0;36m[node1] [06-11|00:50:35.337] INFO indexer/index.go:100 created new index {"nextAcceptedIndex": 0}
+[0;0m[0;36m[node1] [06-11|00:50:35.337] INFO server/server.go:308 adding route {"url": "/ext/index/P", "endpoint": "/block"}
+[0;0m[0;36m[node1] [06-11|00:50:35.338] INFO
bootstrap/bootstrapper.go:115 starting bootstrapper
+[0;0m[0;36m[node1] [06-11|00:50:35.338] INFO
common/bootstrapper.go:310 bootstrapping skipped {"reason": "no provided bootstraps"}
+[0;0m[0;36m[node1] [06-11|00:50:35.338] INFO
bootstrap/bootstrapper.go:554 executing blocks {"numPendingJobs": 0}
+[0;0m[0;36m[node1] [06-11|00:50:35.338] INFO
queue/jobs.go:224 executed operations {"numExecuted": 0}
+[0;0m[0;36m[node1] [06-11|00:50:35.338] INFO
bootstrap/bootstrapper.go:599 waiting for the remaining chains in this subnet to finish syncing
+[0;0m[0;36m[node1] [06-11|00:50:35.338] INFO chains/manager.go:1338 starting chain creator
+[0;0m[0;36m[node1] [06-11|00:50:35.338] INFO chains/manager.go:319 creating chain {"subnetID": "11111111111111111111111111111111LpoYY", "chainID": "23JVJWr6QVJi91LuVNh8e2Cpd4vFe9ApVBzJf5yfq8hAFnd76Z", "vmID": "mgj786NP7uDwBCcq6YwThhaN8FLyybkCa4zBWTQbNgmK6k9A6"}
+[0;0m[0;36m[node1] [06-11|00:50:35.338] INFO server/server.go:184 HTTP API server listening {"host": "127.0.0.1", "port": 9650}
+[0;0m[0;36m[node1] [06-11|00:50:35.339] INFO chains/manager.go:1102 creating proposervm wrapper {"activationTime": "[12-05|05:00:00.000]", "minPChainHeight": 0, "minBlockDelay": "1s"}
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.340] github.com/ava-labs/coreth/plugin/evm/vm.go:353: Initializing Coreth VM Version=v0.12.0 Config="{SnowmanAPIEnabled:false CorethAdminAPIEnabled:false CorethAdminAPIDir: EnabledEthAPIs:[eth eth-filter net web3 internal-eth internal-blockchain internal-transaction internal-account] ContinuousProfilerDir: ContinuousProfilerFrequency:15m0s ContinuousProfilerMaxFiles:5 RPCGasCap:50000000 RPCTxFeeCap:100 TrieCleanCache:512 TrieCleanJournal: TrieCleanRejournal:0s TrieDirtyCache:256 TrieDirtyCommitTarget:20 SnapshotCache:256 Preimages:false SnapshotAsync:true SnapshotVerify:false Pruning:true AcceptorQueueLimit:64 CommitInterval:4096 AllowMissingTries:false PopulateMissingTries: PopulateMissingTriesParallelism:1024 MetricsExpensiveEnabled:false LocalTxsEnabled:false TxPoolJournal:transactions.rlp TxPoolRejournal:1h0m0s TxPoolPriceLimit:1 TxPoolPriceBump:10 TxPoolAccountSlots:16 TxPoolGlobalSlots:5120 TxPoolAccountQueue:64 TxPoolGlobalQueue:1024 APIMaxDuration:0s WSCPURefillRate:0s WSCPUMaxStored:0s MaxBlocksPerRequest:0 AllowUnfinalizedQueries:false AllowUnprotectedTxs:false AllowUnprotectedTxHashes:[0xfefb2da535e927b85fe68eb81cb2e4a5827c905f78381a01ef2322aa9b0aee8e] KeystoreDirectory: KeystoreExternalSigner: KeystoreInsecureUnlockAllowed:false RemoteTxGossipOnlyEnabled:false TxRegossipFrequency:1m0s TxRegossipMaxSize:15 LogLevel:debug LogJSONFormat:false OfflinePruning:false OfflinePruningBloomFilterSize:512 OfflinePruningDataDirectory: MaxOutboundActiveRequests:16 MaxOutboundActiveCrossChainRequests:64 StateSyncEnabled: StateSyncSkipResume:false StateSyncServerTrieCache:64 StateSyncIDs: StateSyncCommitInterval:16384 StateSyncMinBlocks:300000 StateSyncRequestSize:1024 InspectDatabase:false SkipUpgradeCheck:false AcceptedCacheSize:32 TxLookupLimit:0}"
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.341] github.com/ava-labs/coreth/trie/database.go:735: Persisted trie from memory database nodes=1 size=151.00B time="12.117µs" gcnodes=0 gcsize=0.00B gctime=0s livenodes=1 livesize=0.00B
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.341] github.com/ava-labs/coreth/plugin/evm/vm.go:429: lastAccepted = 0xb81c22ceb61ecbb2efaaf4199f82a7c870850b45f41cc9490edf0e06be0e6bb9
+[0;0m[0;36m[node1] DEBUG[06-11|00:50:35.341] github.com/ava-labs/coreth/accounts/keystore/file_cache.go:100: FS scan times list="50.76µs" set=583ns diff="1.084µs"
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.341] github.com/ava-labs/coreth/eth/backend.go:134: Allocated memory caches trie clean=512.00MiB trie dirty=256.00MiB snapshot clean=256.00MiB
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.341] github.com/ava-labs/coreth/eth/backend.go:171: Initialising Ethereum protocol network=43112 dbversion=
+[0;0m[0;36m[node1] WARN [06-11|00:50:35.341] github.com/ava-labs/coreth/eth/backend.go:177: Upgrade blockchain database version from= to=8
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.341] github.com/ava-labs/coreth/core/genesis.go:176: Writing genesis to database
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.342] github.com/ava-labs/coreth/trie/database.go:735: Persisted trie from memory database nodes=1 size=151.00B time="18.909µs" gcnodes=0 gcsize=0.00B gctime=0s livenodes=1 livesize=0.00B
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.342] github.com/ava-labs/coreth/core/blockchain.go:306:
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.342] github.com/ava-labs/coreth/core/blockchain.go:307: ---------------------------------------------------------------------------------------------------------------------------------------------------------
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.342] github.com/ava-labs/coreth/core/blockchain.go:309: Chain ID: 43112
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.342] github.com/ava-labs/coreth/core/blockchain.go:309: Consensus: Dummy Consensus Engine
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.342] github.com/ava-labs/coreth/core/blockchain.go:309:
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.342] github.com/ava-labs/coreth/core/blockchain.go:309: Hard Forks:
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.342] github.com/ava-labs/coreth/core/blockchain.go:309: - Homestead: 0 (https://github.com/ethereum/execution-specs/blob/master/network-upgrades/mainnet-upgrades/homestead.md)
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.342] github.com/ava-labs/coreth/core/blockchain.go:309: - DAO Fork: 0 (https://github.com/ethereum/execution-specs/blob/master/network-upgrades/mainnet-upgrades/dao-fork.md)
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.342] github.com/ava-labs/coreth/core/blockchain.go:309: - Tangerine Whistle (EIP 150): 0 (https://github.com/ethereum/execution-specs/blob/master/network-upgrades/mainnet-upgrades/tangerine-whistle.md)
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.342] github.com/ava-labs/coreth/core/blockchain.go:309: - Spurious Dragon/1 (EIP 155): 0 (https://github.com/ethereum/execution-specs/blob/master/network-upgrades/mainnet-upgrades/spurious-dragon.md)
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.342] github.com/ava-labs/coreth/core/blockchain.go:309: - Spurious Dragon/2 (EIP 158): 0 (https://github.com/ethereum/execution-specs/blob/master/network-upgrades/mainnet-upgrades/spurious-dragon.md)
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.342] github.com/ava-labs/coreth/core/blockchain.go:309: - Byzantium: 0 (https://github.com/ethereum/execution-specs/blob/master/network-upgrades/mainnet-upgrades/byzantium.md)
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.342] github.com/ava-labs/coreth/core/blockchain.go:309: - Constantinople: 0 (https://github.com/ethereum/execution-specs/blob/master/network-upgrades/mainnet-upgrades/constantinople.md)
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.342] github.com/ava-labs/coreth/core/blockchain.go:309: - Petersburg: 0 (https://github.com/ethereum/execution-specs/blob/master/network-upgrades/mainnet-upgrades/petersburg.md)
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.342] github.com/ava-labs/coreth/core/blockchain.go:309: - Istanbul: 0 (https://github.com/ethereum/execution-specs/blob/master/network-upgrades/mainnet-upgrades/istanbul.md)
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.342] github.com/ava-labs/coreth/core/blockchain.go:309: - Muir Glacier: 0 (https://github.com/ethereum/execution-specs/blob/master/network-upgrades/mainnet-upgrades/muir-glacier.md)
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.342] github.com/ava-labs/coreth/core/blockchain.go:309: - Apricot Phase 1 Timestamp: 0 (https://github.com/ava-labs/avalanchego/releases/tag/v1.3.0)
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.342] github.com/ava-labs/coreth/core/blockchain.go:309: - Apricot Phase 2 Timestamp: 0 (https://github.com/ava-labs/avalanchego/releases/tag/v1.4.0)
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.342] github.com/ava-labs/coreth/core/blockchain.go:309: - Apricot Phase 3 Timestamp: 0 (https://github.com/ava-labs/avalanchego/releases/tag/v1.5.0)
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.342] github.com/ava-labs/coreth/core/blockchain.go:309: - Apricot Phase 4 Timestamp: 0 (https://github.com/ava-labs/avalanchego/releases/tag/v1.6.0)
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.342] github.com/ava-labs/coreth/core/blockchain.go:309: - Apricot Phase 5 Timestamp: 0 (https://github.com/ava-labs/avalanchego/releases/tag/v1.7.0)
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.342] github.com/ava-labs/coreth/core/blockchain.go:309: - Apricot Phase P6 Timestamp 0 (https://github.com/ava-labs/avalanchego/releases/tag/v1.8.0)
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.342] github.com/ava-labs/coreth/core/blockchain.go:309: - Apricot Phase 6 Timestamp: 0 (https://github.com/ava-labs/avalanchego/releases/tag/v1.8.0)
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.342] github.com/ava-labs/coreth/core/blockchain.go:309: - Apricot Phase Post-6 Timestamp: 0 (https://github.com/ava-labs/avalanchego/releases/tag/v1.8.0
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.342] github.com/ava-labs/coreth/core/blockchain.go:309: - Banff Timestamp: 0 (https://github.com/ava-labs/avalanchego/releases/tag/v1.9.0)
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.342] github.com/ava-labs/coreth/core/blockchain.go:309: - Cortina Timestamp: 0 (https://github.com/ava-labs/avalanchego/releases/tag/v1.10.0)
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.342] github.com/ava-labs/coreth/core/blockchain.go:309: - DUpgrade Timestamp (https://github.com/ava-labs/avalanchego/releases/tag/v1.11.0)
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.342] github.com/ava-labs/coreth/core/blockchain.go:309:
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.342] github.com/ava-labs/coreth/core/blockchain.go:309:
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.342] github.com/ava-labs/coreth/core/blockchain.go:311: ---------------------------------------------------------------------------------------------------------------------------------------------------------
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.342] github.com/ava-labs/coreth/core/blockchain.go:312:
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.343] github.com/ava-labs/coreth/core/blockchain.go:710: Loaded most recent local header number=0 hash=b81c22..0e6bb9 age=54y2mo2w
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.344] github.com/ava-labs/coreth/core/blockchain.go:711: Loaded most recent local full block number=0 hash=b81c22..0e6bb9 age=54y2mo2w
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.344] github.com/ava-labs/coreth/core/blockchain.go:1722: Loaded Acceptor tip hash=000000..000000
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.344] github.com/ava-labs/coreth/core/blockchain.go:1730: Skipping state reprocessing root=3cbfcc..68c8b4
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.344] github.com/ava-labs/coreth/core/blockchain.go:544: Not warming accepted cache because there are no accepted blocks
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.344] github.com/ava-labs/coreth/core/blockchain.go:567: Starting Acceptor queue length=64
+[0;0m[0;36m[node1] DEBUG[06-11|00:50:35.344] github.com/ava-labs/coreth/core/tx_pool.go:1408: Reinjecting stale transactions count=0
+[0;0m[0;36m[node1] WARN [06-11|00:50:35.344] github.com/ava-labs/coreth/core/rawdb/accessors_metadata.go:111: Error reading unclean shutdown markers error="not found"
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.344] github.com/ava-labs/coreth/core/tx_pool.go:505: Transaction pool price threshold updated price=470,000,000,000
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.344] github.com/ava-labs/coreth/core/tx_pool.go:505: Transaction pool price threshold updated price=225,000,000,000
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.344] github.com/ava-labs/coreth/core/tx_pool.go:505: Transaction pool price threshold updated price=0
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.345] github.com/ava-labs/coreth/plugin/evm/atomic_tx_repository.go:115: Initializing atomic transaction repository from scratch
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.345] github.com/ava-labs/coreth/plugin/evm/atomic_tx_repository.go:191: Completed atomic transaction repository migration lastAcceptedHeight=0 duration="163.072µs"
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.345] github.com/ava-labs/coreth/plugin/evm/atomic_tx_repository.go:438: atomic tx repository RepairForBonusBlocks complete repairedEntries=0
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.346] github.com/ava-labs/coreth/plugin/evm/atomic_backend.go:132: initializing atomic trie lastCommittedHeight=0
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.346] github.com/ava-labs/coreth/plugin/evm/atomic_backend.go:210: finished initializing atomic trie lastAcceptedHeight=0 lastAcceptedAtomicRoot=56e81f..63b421 heightsIndexed=0 lastCommittedRoot=56e81f..63b421 lastCommittedHeight=0 time="91.043µs"
+[0;0m[0;36m[node1] [06-11|00:50:35.347] INFO proposervm/vm.go:356 block height index was successfully verified
+[0;0m[0;36m[node1] [06-11|00:50:35.350] INFO snowman/transitive.go:89 initializing consensus engine
+[0;0m[0;36m[node1] INFO [06-11|00:50:35.352] github.com/ava-labs/coreth/plugin/evm/vm.go:1171: Enabled APIs: eth, eth-filter, net, web3, internal-eth, internal-blockchain, internal-transaction, internal-account, avax
+[0;0m[0;36m[node1] DEBUG[06-11|00:50:35.352] github.com/ava-labs/coreth/rpc/websocket.go:104: Allowed origin(s) for WS RPC interface [*]
+[0;0m[0;36m[node1] [06-11|00:50:35.352] INFO server/server.go:269 adding route {"url": "/ext/bc/23JVJWr6QVJi91LuVNh8e2Cpd4vFe9ApVBzJf5yfq8hAFnd76Z", "endpoint": "/avax"}
+[0;0m[0;36m[node1] [06-11|00:50:35.353] INFO server/server.go:269 adding route {"url": "/ext/bc/23JVJWr6QVJi91LuVNh8e2Cpd4vFe9ApVBzJf5yfq8hAFnd76Z", "endpoint": "/rpc"}
+[0;0m[0;36m[node1] [06-11|00:50:35.353] INFO server/server.go:269 adding route {"url": "/ext/bc/23JVJWr6QVJi91LuVNh8e2Cpd4vFe9ApVBzJf5yfq8hAFnd76Z", "endpoint": "/ws"}
+[0;0m[0;36m[node1] [06-11|00:50:35.353] INFO indexer/index.go:100 created new index {"nextAcceptedIndex": 0}
+[0;0m[0;36m[node1] [06-11|00:50:35.353] INFO server/server.go:308 adding route {"url": "/ext/index/C", "endpoint": "/block"}
+[0;0m[0;36m[node1] [06-11|00:50:35.354] INFO syncer/state_syncer.go:385 starting state sync
+[0;0m[0;36m[node1] [06-11|00:50:35.354] INFO chains/manager.go:319 creating chain {"subnetID": "11111111111111111111111111111111LpoYY", "chainID": "qzfF3A11KzpcHkkqznEyQgupQrCNS6WV6fTUTwZpEKqhj1QE7", "vmID": "jvYyfQTxGMJLuGWa55kdP2p2zSUYsQ5Raupu4TW34ZAUBAbtq"}
+[0;0m[0;36m[node1] DEBUG[06-11|00:50:35.354] github.com/ava-labs/coreth/peer/network.go:486: adding new peer nodeID=NodeID-7Xhw2mDxuDS44j42TCB6U5579esbSt3Lg
+[0;0m[0;36m[node1] DEBUG[06-11|00:50:35.354] github.com/ava-labs/coreth/peer/network.go:496: skipping registering self as peer
+[0;0m[0;36m[node1] [06-11|00:50:35.357] INFO avm/vm.go:636 initializing genesis asset {"txID": "BUuypiq2wyuLMvyhzFXcPyxPMCgSp7eeDohhQRqTChoBjKziC"}
+[0;0m[0;36m[node1] [06-11|00:50:35.357] INFO avm/vm.go:619 fee asset is established {"alias": "AVAX", "assetID": "BUuypiq2wyuLMvyhzFXcPyxPMCgSp7eeDohhQRqTChoBjKziC"}
+[0;0m[0;36m[node1] [06-11|00:50:35.357] INFO avm/vm.go:275 address transaction indexing is disabled
+[0;0m[0;36m[node1] [06-11|00:50:35.358] INFO chains/manager.go:756 creating proposervm wrapper {"activationTime": "[12-05|05:00:00.000]", "minPChainHeight": 0, "minBlockDelay": "1s"}
+[0;0m[0;36m[node1] [06-11|00:50:35.361] INFO snowman/transitive.go:89 initializing consensus engine
+[0;0m[0;36m[node1] [06-11|00:50:35.362] INFO server/server.go:269 adding route {"url": "/ext/bc/qzfF3A11KzpcHkkqznEyQgupQrCNS6WV6fTUTwZpEKqhj1QE7", "endpoint": "/events"}
+[0;0m[0;36m[node1] [06-11|00:50:35.363] INFO server/server.go:269 adding route {"url": "/ext/bc/qzfF3A11KzpcHkkqznEyQgupQrCNS6WV6fTUTwZpEKqhj1QE7", "endpoint": ""}
+[0;0m[0;36m[node1] [06-11|00:50:35.363] INFO server/server.go:269 adding route {"url": "/ext/bc/qzfF3A11KzpcHkkqznEyQgupQrCNS6WV6fTUTwZpEKqhj1QE7", "endpoint": "/wallet"}
+[0;0m[0;36m[node1] [06-11|00:50:35.363] INFO indexer/index.go:100 created new index {"nextAcceptedIndex": 0}
+[0;0m[0;36m[node1] [06-11|00:50:35.363] INFO server/server.go:308 adding route {"url": "/ext/index/X", "endpoint": "/block"}
+[0;0m[0;36m[node1] [06-11|00:50:35.363] INFO indexer/index.go:100 created new index {"nextAcceptedIndex": 0}
+[0;0m[0;36m[node1] [06-11|00:50:35.363] INFO server/server.go:308 adding route {"url": "/ext/index/X", "endpoint": "/vtx"}
+[0;0m[0;36m[node1] [06-11|00:50:35.364] INFO indexer/index.go:100 created new index {"nextAcceptedIndex": 0}
+[0;0m[0;36m[node1] [06-11|00:50:35.364] INFO server/server.go:308 adding route {"url": "/ext/index/X", "endpoint": "/tx"}
+[0;0m[0;36m[node1] [06-11|00:50:35.364] INFO bootstrap/bootstrapper.go:290 starting bootstrap
+[0;0m[0;36m[node1] [06-11|00:50:35.364] INFO bootstrap/bootstrapper.go:347 accepted stop vertex {"vtxID": "sj8adpSGCc7k7aWFNkiugYvUSHGq9xUvJPb8VzdVPXv9u2b5X"}
+[0;0m[0;36m[node1] [06-11|00:50:35.364] INFO bootstrap/bootstrapper.go:571 executing transactions
+[0;0m[0;36m[node1] [06-11|00:50:35.364] INFO queue/jobs.go:224 executed operations {"numExecuted": 0}
+[0;0m[0;36m[node1] [06-11|00:50:35.364] INFO bootstrap/bootstrapper.go:588 executing vertices
+[0;0m[0;36m[node1] [06-11|00:50:35.364] INFO queue/jobs.go:224 executed operations {"numExecuted": 0}
+[0;0m[0;36m[node1] [06-11|00:50:35.365] INFO bootstrap/bootstrapper.go:115 starting bootstrapper
+[0;0m[1;34m[node2] [06-11|00:50:35.424] WARN app/app.go:153 P2P IP is private, you will not be publicly discoverable {"ip": "127.0.0.1"}
+[0;0m[1;34m[node2] [06-11|00:50:35.425] INFO node/node.go:1251 initializing node {"version": "avalanche/1.10.1", "nodeID": "NodeID-MFrZFVCXPv5iCn6M9K6XduxGTYp891xXZ", "nodePOP": {"publicKey":"0x8b49c4259529a801cc961c72248773b550379ff718a49f4ccc0e1f2ac338fe204432329aa1712f408f97eee12b22dd05","proofOfPossession":"0xaf92674c3615d462527675da121b06023b116ddebc6e163919e562ab7cbe6adf20515cd2fc17c3e2d2d59953f285229e15f04302187bef5a4aa3ebdea1d18bf34047be654dd12491e882fb90b17b3cbde99ad43fc5cd0c26828bbe49a4b9456c"}, "providedFlags": {"api-admin-enabled":true,"api-ipcs-enabled":true,"bootstrap-ids":"NodeID-7Xhw2mDxuDS44j42TCB6U5579esbSt3Lg","bootstrap-ips":"[::1]:9651","chain-config-dir":"/tmp/network-runner-root-data_20230611_005034/node2/chainConfigs","consensus-app-concurrency":"512","consensus-on-accept-gossip-peer-size":"10","consensus-on-accept-gossip-validator-size":"10","data-dir":"/tmp/network-runner-root-data_20230611_005034/node2","db-dir":"/tmp/network-runner-root-data_20230611_005034/node2/db","genesis":"/tmp/network-runner-root-data_20230611_005034/node2/genesis.json","health-check-frequency":"2s","http-port":"9652","index-enabled":true,"log-dir":"/tmp/network-runner-root-data_20230611_005034/node2/logs","log-display-level":"info","log-level":"DEBUG","network-compression-type":"none","network-id":"1337","network-max-reconnect-delay":"1s","network-peer-list-gossip-frequency":"250ms","plugin-dir":"/tmp/avalanchego-v1.10.1/plugins","proposervm-use-current-height":true,"public-ip":"127.0.0.1","snow-mixed-query-num-push-vdr":"10","staking-port":"9653","staking-signer-key-file":"/tmp/network-runner-root-data_20230611_005034/node2/signer.key","staking-tls-cert-file":"/tmp/network-runner-root-data_20230611_005034/node2/staking.crt","staking-tls-key-file":"/tmp/network-runner-root-data_20230611_005034/node2/staking.key","subnet-config-dir":"/tmp/network-runner-root-data_20230611_005034/node2/subnetConfigs","throttler-inbound-at-large-alloc-size":"10737418240","throttler-inbound-bandwidth-max-burst-size":"1073741824","throttler-inbound-bandwidth-refill-rate":"1073741824","throttler-inbound-cpu-validator-alloc":"100000","throttler-inbound-disk-validator-alloc":"1.073741824e+13","throttler-inbound-node-max-processing-msgs":"100000","throttler-inbound-validator-alloc-size":"10737418240","throttler-outbound-at-large-alloc-size":"10737418240","throttler-outbound-validator-alloc-size":"10737418240"}, "config": {"httpConfig":{"readTimeout":30000000000,"readHeaderTimeout":30000000000,"writeHeaderTimeout":30000000000,"idleTimeout":120000000000,"apiConfig":{"authConfig":{"apiRequireAuthToken":false},"indexerConfig":{"indexAPIEnabled":true,"indexAllowIncomplete":false},"ipcConfig":{"ipcAPIEnabled":true,"ipcPath":"/tmp","ipcDefaultChainIDs":null},"adminAPIEnabled":true,"infoAPIEnabled":true,"keystoreAPIEnabled":false,"metricsAPIEnabled":true,"healthAPIEnabled":true},"httpHost":"127.0.0.1","httpPort":9652,"httpsEnabled":false,"apiAllowedOrigins":["*"],"shutdownTimeout":10000000000,"shutdownWait":0},"ipConfig":{"ip":{"ip":"127.0.0.1","port":9653},"ipResolutionFrequency":300000000000,"attemptedNATTraversal":false},"stakingConfig":{"uptimeRequirement":0.8,"minValidatorStake":2000000000000,"maxValidatorStake":3000000000000000,"minDelegatorStake":25000000000,"minDelegationFee":20000,"minStakeDuration":86400000000000,"maxStakeDuration":31536000000000000,"rewardConfig":{"maxConsumptionRate":120000,"minConsumptionRate":100000,"mintingPeriod":31536000000000000,"supplyCap":720000000000000000},"enableStaking":true,"disabledStakingWeight":100,"stakingKeyPath":"/tmp/network-runner-root-data_20230611_005034/node2/staking.key","stakingCertPath":"/tmp/network-runner-root-data_20230611_005034/node2/staking.crt","stakingSignerPath":"/tmp/network-runner-root-data_20230611_005034/node2/signer.key"},"txFeeConfig":{"txFee":1000000,"createAssetTxFee":1000000,"createSubnetTxFee":100000000,"transformSubnetTxFee":100000000,"createBlockchainTxFee":100000000,"addPrimaryNetworkValidatorFee":0,"addPrimaryNetworkDelegatorFee":0,"addSubnetValidatorFee":1000000,"addSubnetDelegatorFee":1000000},"stateSyncConfig":{"stateSyncIDs":null,"stateSyncIPs":null},"bootstrapConfig":{"retryBootstrap":true,"retryBootstrapWarnFrequency":50,"bootstrapBeaconConnectionTimeout":60000000000,"bootstrapAncestorsMaxContainersSent":2000,"bootstrapAncestorsMaxContainersReceived":2000,"bootstrapMaxTimeGetAncestors":50000000,"bootstrapIDs":["NodeID-7Xhw2mDxuDS44j42TCB6U5579esbSt3Lg"],"bootstrapIPs":[{"ip":"::1","port":9651}]},"databaseConfig":{"path":"/tmp/network-runner-root-data_20230611_005034/node2/db/network-1337","name":"leveldb"},"avaxAssetID":"BUuypiq2wyuLMvyhzFXcPyxPMCgSp7eeDohhQRqTChoBjKziC","networkID":1337,"healthCheckFreq":2000000000,"networkConfig":{"healthConfig":{"minConnectedPeers":1,"maxTimeSinceMsgReceived":60000000000,"maxTimeSinceMsgSent":60000000000,"maxPortionSendQueueBytesFull":0.9,"maxSendFailRate":0.9,"sendFailRateHalflife":10000000000},"peerListGossipConfig":{"peerListNumValidatorIPs":15,"peerListValidatorGossipSize":20,"peerListNonValidatorGossipSize":0,"peerListPeersGossipSize":10,"peerListGossipFreq":250000000},"timeoutConfigs":{"pingPongTimeout":30000000000,"readHandshakeTimeout":15000000000},"delayConfig":{"initialReconnectDelay":1000000000,"maxReconnectDelay":1000000000},"throttlerConfig":{"inboundConnUpgradeThrottlerConfig":{"upgradeCooldown":10000000000,"maxRecentConnsUpgraded":2560},"inboundMsgThrottlerConfig":{"byteThrottlerConfig":{"vdrAllocSize":10737418240,"atLargeAllocSize":10737418240,"nodeMaxAtLargeBytes":2097152},"bandwidthThrottlerConfig":{"bandwidthRefillRate":1073741824,"bandwidthMaxBurstRate":1073741824},"cpuThrottlerConfig":{"maxRecheckDelay":5000000000},"diskThrottlerConfig":{"maxRecheckDelay":5000000000},"maxProcessingMsgsPerNode":100000},"outboundMsgThrottlerConfig":{"vdrAllocSize":10737418240,"atLargeAllocSize":10737418240,"nodeMaxAtLargeBytes":2097152},"maxInboundConnsPerSec":256},"proxyEnabled":false,"proxyReadHeaderTimeout":3000000000,"dialerConfig":{"throttleRps":50,"connectionTimeout":30000000000},"tlsKeyLogFile":"","namespace":"","myNodeID":"NodeID-111111111111111111116DBWJs","myIP":null,"networkID":0,"maxClockDifference":60000000000,"pingFrequency":22500000000,"allowPrivateIPs":true,"compressionType":"none","uptimeMetricFreq":30000000000,"requireValidatorToConnect":false,"maximumInboundMessageTimeout":10000000000,"peerReadBufferSize":8192,"peerWriteBufferSize":8192},"adaptiveTimeoutConfig":{"initialTimeout":5000000000,"minimumTimeout":2000000000,"maximumTimeout":10000000000,"timeoutCoefficient":2,"timeoutHalflife":300000000000},"benchlistConfig":{"threshold":10,"minimumFailingDuration":150000000000,"duration":900000000000,"maxPortion":0.08333333333333333},"profilerConfig":{"dir":"/tmp/network-runner-root-data_20230611_005034/node2/profiles","enabled":false,"freq":900000000000,"maxNumFiles":5},"loggingConfig":{"maxSize":8,"maxFiles":7,"maxAge":0,"directory":"/tmp/network-runner-root-data_20230611_005034/node2/logs","compress":false,"disableWriterDisplaying":false,"logLevel":"DEBUG","displayLevel":"INFO","logFormat":"PLAIN"},"pluginDir":"/tmp/avalanchego-v1.10.1/plugins","fdLimit":32768,"meterVMEnabled":true,"routerHealthConfig":{"maxDropRate":1,"maxDropRateHalflife":10000000000,"maxOutstandingRequests":1024,"maxOutstandingDuration":300000000000,"maxRunTimeRequests":10000000000},"consensusShutdownTimeout":30000000000,"consensusGossipFreq":10000000000,"consensusAppConcurrency":512,"trackedSubnets":[],"subnetConfigs":{"11111111111111111111111111111111LpoYY":{"gossipAcceptedFrontierValidatorSize":0,"gossipAcceptedFrontierNonValidatorSize":0,"gossipAcceptedFrontierPeerSize":15,"gossipOnAcceptValidatorSize":10,"gossipOnAcceptNonValidatorSize":0,"gossipOnAcceptPeerSize":10,"appGossipValidatorSize":10,"appGossipNonValidatorSize":0,"appGossipPeerSize":0,"validatorOnly":false,"allowedNodes":null,"consensusParameters":{"k":20,"alpha":15,"betaVirtuous":20,"betaRogue":20,"concurrentRepolls":4,"optimalProcessing":10,"maxOutstandingItems":256,"maxItemProcessingTime":30000000000,"mixedQueryNumPushVdr":10,"mixedQueryNumPushNonVdr":0},"proposerMinBlockDelay":1000000000,"minPercentConnectedStakeHealthy":0}},"chainAliases":null,"systemTrackerProcessingHalflife":15000000000,"systemTrackerFrequency":500000000,"systemTrackerCPUHalflife":15000000000,"systemTrackerDiskHalflife":60000000000,"cpuTargeterConfig":{"vdrAlloc":100000,"maxNonVdrUsage":44.800000000000004,"maxNonVdrNodeUsage":7},"diskTargeterConfig":{"vdrAlloc":10737418240000,"maxNonVdrUsage":1073741824000,"maxNonVdrNodeUsage":1073741824000},"requiredAvailableDiskSpace":536870912,"warningThresholdAvailableDiskSpace":1073741824,"traceConfig":{"exporterConfig":{"type":"unknown","endpoint":"","headers":null,"insecure":false},"enabled":false,"traceSampleRate":0},"minPercentConnectedStakeHealthy":{"11111111111111111111111111111111LpoYY":0.8},"useCurrentHeight":true,"chainDataDir":"/tmp/network-runner-root-data_20230611_005034/node2/chainData"}}
+[0;0m[1;34m[node2] [06-11|00:50:35.426] INFO node/node.go:582 initializing API server
+[0;0m[1;34m[node2] [06-11|00:50:35.426] INFO server/server.go:147 API created {"allowedOrigins": ["*"]}
+[0;0m[1;34m[node2] [06-11|00:50:35.426] INFO node/node.go:912 initializing metrics API
+[0;0m[1;34m[node2] [06-11|00:50:35.426] INFO server/server.go:308 adding route {"url": "/ext/metrics", "endpoint": ""}
+[0;0m[1;34m[node2] [06-11|00:50:35.426] INFO leveldb/db.go:208 creating leveldb {"config": {"blockCacheCapacity":12582912,"blockSize":0,"compactionExpandLimitFactor":0,"compactionGPOverlapsFactor":0,"compactionL0Trigger":0,"compactionSourceLimitFactor":0,"compactionTableSize":0,"compactionTableSizeMultiplier":0,"compactionTableSizeMultiplierPerLevel":null,"compactionTotalSize":0,"compactionTotalSizeMultiplier":0,"disableSeeksCompaction":true,"openFilesCacheCapacity":1024,"writeBuffer":6291456,"filterBitsPerKey":10,"maxManifestFileSize":9223372036854775807,"metricUpdateFrequency":10000000000}}
+[0;0m[06-11|00:50:35.449] INFO local/network.go:587 adding node {"node-name": "node3", "node-dir": "/tmp/network-runner-root-data_20230611_005034/node3", "log-dir": "/tmp/network-runner-root-data_20230611_005034/node3/logs", "db-dir": "/tmp/network-runner-root-data_20230611_005034/node3/db", "p2p-port": 9655, "api-port": 9654}
+[06-11|00:50:35.449] DEBUG local/network.go:597 starting node {"name": "node3", "binaryPath": "/tmp/avalanchego-v1.10.1/avalanchego", "args": ["--index-enabled=true", "--bootstrap-ips=[::1]:9651,[::1]:9653", "--throttler-outbound-at-large-alloc-size=10737418240", "--throttler-inbound-node-max-processing-msgs=100000", "--health-check-frequency=2s", "--log-display-level=info", "--log-level=DEBUG", "--staking-port=9655", "--throttler-outbound-validator-alloc-size=10737418240", "--api-admin-enabled=true", "--genesis=/tmp/network-runner-root-data_20230611_005034/node3/genesis.json", "--network-compression-type=none", "--http-port=9654", "--proposervm-use-current-height=true", "--log-dir=/tmp/network-runner-root-data_20230611_005034/node3/logs", "--throttler-inbound-bandwidth-max-burst-size=1073741824", "--throttler-inbound-bandwidth-refill-rate=1073741824", "--network-peer-list-gossip-frequency=250ms", "--throttler-inbound-at-large-alloc-size=10737418240", "--bootstrap-ids=NodeID-7Xhw2mDxuDS44j42TCB6U5579esbSt3Lg,NodeID-MFrZFVCXPv5iCn6M9K6XduxGTYp891xXZ", "--throttler-inbound-validator-alloc-size=10737418240", "--consensus-on-accept-gossip-validator-size=10", "--subnet-config-dir=/tmp/network-runner-root-data_20230611_005034/node3/subnetConfigs", "--db-dir=/tmp/network-runner-root-data_20230611_005034/node3/db", "--public-ip=127.0.0.1", "--snow-mixed-query-num-push-vdr=10", "--consensus-on-accept-gossip-peer-size=10", "--network-id=1337", "--staking-tls-cert-file=/tmp/network-runner-root-data_20230611_005034/node3/staking.crt", "--throttler-inbound-disk-validator-alloc=10737418240000", "--plugin-dir=/tmp/avalanchego-v1.10.1/plugins", "--chain-config-dir=/tmp/network-runner-root-data_20230611_005034/node3/chainConfigs", "--staking-tls-key-file=/tmp/network-runner-root-data_20230611_005034/node3/staking.key", "--data-dir=/tmp/network-runner-root-data_20230611_005034/node3", "--api-ipcs-enabled=true", "--throttler-inbound-cpu-validator-alloc=100000", "--staking-signer-key-file=/tmp/network-runner-root-data_20230611_005034/node3/signer.key", "--network-max-reconnect-delay=1s", "--consensus-app-concurrency=512"]}
+[1;34m[node2] [06-11|00:50:35.458] INFO node/node.go:452 initializing database {"dbVersion": "v1.4.5"}
+[0;0m[1;34m[node2] [06-11|00:50:35.458] INFO node/node.go:869 initializing keystore
+[0;0m[1;34m[node2] [06-11|00:50:35.458] INFO node/node.go:877 skipping keystore API initialization because it has been disabled
+[0;0m[1;34m[node2] [06-11|00:50:35.458] INFO node/node.go:861 initializing SharedMemory
+[0;0m[1;34m[node2] [06-11|00:50:35.481] INFO node/node.go:232 initializing networking {"currentNodeIP": "127.0.0.1:9653"}
+[0;0m[1;34m[node2] [06-11|00:50:35.482] INFO node/node.go:1032 initializing Health API
+[0;0m[1;34m[node2] [06-11|00:50:35.482] INFO server/server.go:308 adding route {"url": "/ext/health", "endpoint": ""}
+[0;0m[1;34m[node2] [06-11|00:50:35.482] INFO server/server.go:308 adding route {"url": "/ext/health", "endpoint": "/readiness"}
+[0;0m[1;34m[node2] [06-11|00:50:35.482] INFO server/server.go:308 adding route {"url": "/ext/health", "endpoint": "/health"}
+[0;0m[1;34m[node2] [06-11|00:50:35.482] INFO server/server.go:308 adding route {"url": "/ext/health", "endpoint": "/liveness"}
+[0;0m[1;34m[node2] [06-11|00:50:35.482] INFO node/node.go:642 adding the default VM aliases
+[0;0m[1;34m[node2] [06-11|00:50:35.482] INFO node/node.go:763 initializing VMs
+[0;0m[1;34m[node2] [06-11|00:50:35.482] INFO server/server.go:308 adding route {"url": "/ext/vm/rWhpuQPF1kb72esV2momhMuTYGkEb1oL29pt2EBXWmSy4kxnT", "endpoint": ""}
+[0;0m[1;34m[node2] [06-11|00:50:35.482] INFO server/server.go:308 adding route {"url": "/ext/vm/jvYyfQTxGMJLuGWa55kdP2p2zSUYsQ5Raupu4TW34ZAUBAbtq", "endpoint": ""}
+[0;0m[1;34m[node2] [06-11|00:50:35.482] INFO server/server.go:308 adding route {"url": "/ext/vm/mgj786NP7uDwBCcq6YwThhaN8FLyybkCa4zBWTQbNgmK6k9A6", "endpoint": "/rpc"}
+[0;0m[1;34m[node2] [06-11|00:50:35.549] INFO subprocess/runtime.go:143 plugin handshake succeeded {"addr": "127.0.0.1:41317"}
+[0;0m[1;34m[node2] runtime engine: received shutdown signal: SIGTERM
+[0;0m[1;34m[node2] vm server: graceful termination success
+[0;0m[1;34m[node2] [06-11|00:50:35.556] INFO subprocess/runtime.go:124 stderr collector shutdown
+[0;0m[1;34m[node2] [06-11|00:50:35.556] INFO subprocess/runtime.go:111 stdout collector shutdown
+[0;0m[1;34m[node2] [06-11|00:50:35.622] INFO subprocess/runtime.go:143 plugin handshake succeeded {"addr": "127.0.0.1:40245"}
+[0;0m[1;34m[node2] [06-11|00:50:35.625] INFO node/node.go:935 initializing admin API
+[0;0m[1;34m[node2] [06-11|00:50:35.625] INFO server/server.go:308 adding route {"url": "/ext/admin", "endpoint": ""}
+[0;0m[1;34m[node2] [06-11|00:50:35.625] INFO node/node.go:984 initializing info API
+[0;0m[1;34m[node2] [06-11|00:50:35.627] INFO server/server.go:308 adding route {"url": "/ext/info", "endpoint": ""}
+[0;0m[1;34m[node2] [06-11|00:50:35.627] WARN node/node.go:1138 initializing deprecated ipc API
+[0;0m[1;34m[node2] [06-11|00:50:35.627] INFO server/server.go:308 adding route {"url": "/ext/ipcs", "endpoint": ""}
+[0;0m[1;34m[node2] [06-11|00:50:35.628] INFO node/node.go:1148 initializing chain aliases
+[0;0m[1;34m[node2] [06-11|00:50:35.628] INFO node/node.go:1175 initializing API aliases
+[0;0m[1;34m[node2] [06-11|00:50:35.628] INFO node/node.go:957 skipping profiler initialization because it has been disabled
+[0;0m[1;34m[node2] [06-11|00:50:35.628] INFO node/node.go:561 initializing chains
+[0;0m[1;34m[node2] [06-11|00:50:35.628] INFO chains/manager.go:319 creating chain {"subnetID": "11111111111111111111111111111111LpoYY", "chainID": "11111111111111111111111111111111LpoYY", "vmID": "rWhpuQPF1kb72esV2momhMuTYGkEb1oL29pt2EBXWmSy4kxnT"}
+[0;0m[1;34m[node2] [06-11|00:50:35.630] INFO chains/manager.go:1102 creating proposervm wrapper {"activationTime": "[12-05|05:00:00.000]", "minPChainHeight": 0, "minBlockDelay": "1s"}
+[0;0m[1;34m[node2] [06-11|00:50:35.633] INFO platformvm/vm.go:228 initializing last accepted {"blkID": "2EYLCg5YdYRx9h3g3odqDB49o35ekw6NtXqJaom7pb3Rpvmonc"}
+[0;0m[1;34m[node2] [06-11|00:50:35.636] INFO
snowman/transitive.go:89 initializing consensus engine
+[0;0m[1;34m[node2] [06-11|00:50:35.637] INFO server/server.go:269 adding route {"url": "/ext/bc/11111111111111111111111111111111LpoYY", "endpoint": ""}
+[0;0m[1;34m[node2] [06-11|00:50:35.637] INFO indexer/index.go:100 created new index {"nextAcceptedIndex": 0}
+[0;0m[1;34m[node2] [06-11|00:50:35.638] INFO server/server.go:308 adding route {"url": "/ext/index/P", "endpoint": "/block"}
+[0;0m[1;34m[node2] [06-11|00:50:35.638] INFO
bootstrap/bootstrapper.go:115 starting bootstrapper
+[0;0m[1;34m[node2] [06-11|00:50:35.638] INFO chains/manager.go:1338 starting chain creator
+[0;0m[1;34m[node2] [06-11|00:50:35.638] INFO server/server.go:184 HTTP API server listening {"host": "127.0.0.1", "port": 9652}
+[0;0m[0;36m[node1] DEBUG[06-11|00:50:35.753] github.com/ava-labs/coreth/peer/network.go:486: adding new peer nodeID=NodeID-MFrZFVCXPv5iCn6M9K6XduxGTYp891xXZ
+[0;0m[1;34m[node2] [06-11|00:50:35.755] INFO common/bootstrapper.go:244 bootstrapping started syncing {"numVerticesInFrontier": 1}
+[0;0m[1;34m[node2] [06-11|00:50:35.755] INFO
bootstrap/bootstrapper.go:554 executing blocks {"numPendingJobs": 0}
+[0;0m[1;34m[node2] [06-11|00:50:35.755] INFO
queue/jobs.go:224 executed operations {"numExecuted": 0}
+[0;0m[1;34m[node2] [06-11|00:50:35.755] INFO
bootstrap/bootstrapper.go:599 waiting for the remaining chains in this subnet to finish syncing
+[0;0m[1;34m[node2] [06-11|00:50:35.755] INFO chains/manager.go:319 creating chain {"subnetID": "11111111111111111111111111111111LpoYY", "chainID": "23JVJWr6QVJi91LuVNh8e2Cpd4vFe9ApVBzJf5yfq8hAFnd76Z", "vmID": "mgj786NP7uDwBCcq6YwThhaN8FLyybkCa4zBWTQbNgmK6k9A6"}
+[0;0m[1;34m[node2] [06-11|00:50:35.757] INFO chains/manager.go:1102 creating proposervm wrapper {"activationTime": "[12-05|05:00:00.000]", "minPChainHeight": 0, "minBlockDelay": "1s"}
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.758] github.com/ava-labs/coreth/plugin/evm/vm.go:353: Initializing Coreth VM Version=v0.12.0 Config="{SnowmanAPIEnabled:false CorethAdminAPIEnabled:false CorethAdminAPIDir: EnabledEthAPIs:[eth eth-filter net web3 internal-eth internal-blockchain internal-transaction internal-account] ContinuousProfilerDir: ContinuousProfilerFrequency:15m0s ContinuousProfilerMaxFiles:5 RPCGasCap:50000000 RPCTxFeeCap:100 TrieCleanCache:512 TrieCleanJournal: TrieCleanRejournal:0s TrieDirtyCache:256 TrieDirtyCommitTarget:20 SnapshotCache:256 Preimages:false SnapshotAsync:true SnapshotVerify:false Pruning:true AcceptorQueueLimit:64 CommitInterval:4096 AllowMissingTries:false PopulateMissingTries: PopulateMissingTriesParallelism:1024 MetricsExpensiveEnabled:false LocalTxsEnabled:false TxPoolJournal:transactions.rlp TxPoolRejournal:1h0m0s TxPoolPriceLimit:1 TxPoolPriceBump:10 TxPoolAccountSlots:16 TxPoolGlobalSlots:5120 TxPoolAccountQueue:64 TxPoolGlobalQueue:1024 APIMaxDuration:0s WSCPURefillRate:0s WSCPUMaxStored:0s MaxBlocksPerRequest:0 AllowUnfinalizedQueries:false AllowUnprotectedTxs:false AllowUnprotectedTxHashes:[0xfefb2da535e927b85fe68eb81cb2e4a5827c905f78381a01ef2322aa9b0aee8e] KeystoreDirectory: KeystoreExternalSigner: KeystoreInsecureUnlockAllowed:false RemoteTxGossipOnlyEnabled:false TxRegossipFrequency:1m0s TxRegossipMaxSize:15 LogLevel:debug LogJSONFormat:false OfflinePruning:false OfflinePruningBloomFilterSize:512 OfflinePruningDataDirectory: MaxOutboundActiveRequests:16 MaxOutboundActiveCrossChainRequests:64 StateSyncEnabled: StateSyncSkipResume:false StateSyncServerTrieCache:64 StateSyncIDs: StateSyncCommitInterval:16384 StateSyncMinBlocks:300000 StateSyncRequestSize:1024 InspectDatabase:false SkipUpgradeCheck:false AcceptedCacheSize:32 TxLookupLimit:0}"
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.760] github.com/ava-labs/coreth/trie/database.go:735: Persisted trie from memory database nodes=1 size=151.00B time="13.075µs" gcnodes=0 gcsize=0.00B gctime=0s livenodes=1 livesize=0.00B
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.760] github.com/ava-labs/coreth/plugin/evm/vm.go:429: lastAccepted = 0xb81c22ceb61ecbb2efaaf4199f82a7c870850b45f41cc9490edf0e06be0e6bb9
+[0;0m[1;34m[node2] DEBUG[06-11|00:50:35.760] github.com/ava-labs/coreth/accounts/keystore/file_cache.go:100: FS scan times list="41.334µs" set=929ns diff="1.51µs"
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.760] github.com/ava-labs/coreth/eth/backend.go:134: Allocated memory caches trie clean=512.00MiB trie dirty=256.00MiB snapshot clean=256.00MiB
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.760] github.com/ava-labs/coreth/eth/backend.go:171: Initialising Ethereum protocol network=43112 dbversion=
+[0;0m[1;34m[node2] WARN [06-11|00:50:35.760] github.com/ava-labs/coreth/eth/backend.go:177: Upgrade blockchain database version from= to=8
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.760] github.com/ava-labs/coreth/core/genesis.go:176: Writing genesis to database
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.761] github.com/ava-labs/coreth/trie/database.go:735: Persisted trie from memory database nodes=1 size=151.00B time="39.98µs" gcnodes=0 gcsize=0.00B gctime=0s livenodes=1 livesize=0.00B
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.761] github.com/ava-labs/coreth/core/blockchain.go:306:
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.761] github.com/ava-labs/coreth/core/blockchain.go:307: ---------------------------------------------------------------------------------------------------------------------------------------------------------
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.761] github.com/ava-labs/coreth/core/blockchain.go:309: Chain ID: 43112
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.762] github.com/ava-labs/coreth/core/blockchain.go:309: Consensus: Dummy Consensus Engine
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.762] github.com/ava-labs/coreth/core/blockchain.go:309:
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.762] github.com/ava-labs/coreth/core/blockchain.go:309: Hard Forks:
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.762] github.com/ava-labs/coreth/core/blockchain.go:309: - Homestead: 0 (https://github.com/ethereum/execution-specs/blob/master/network-upgrades/mainnet-upgrades/homestead.md)
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.762] github.com/ava-labs/coreth/core/blockchain.go:309: - DAO Fork: 0 (https://github.com/ethereum/execution-specs/blob/master/network-upgrades/mainnet-upgrades/dao-fork.md)
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.762] github.com/ava-labs/coreth/core/blockchain.go:309: - Tangerine Whistle (EIP 150): 0 (https://github.com/ethereum/execution-specs/blob/master/network-upgrades/mainnet-upgrades/tangerine-whistle.md)
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.762] github.com/ava-labs/coreth/core/blockchain.go:309: - Spurious Dragon/1 (EIP 155): 0 (https://github.com/ethereum/execution-specs/blob/master/network-upgrades/mainnet-upgrades/spurious-dragon.md)
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.762] github.com/ava-labs/coreth/core/blockchain.go:309: - Spurious Dragon/2 (EIP 158): 0 (https://github.com/ethereum/execution-specs/blob/master/network-upgrades/mainnet-upgrades/spurious-dragon.md)
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.762] github.com/ava-labs/coreth/core/blockchain.go:309: - Byzantium: 0 (https://github.com/ethereum/execution-specs/blob/master/network-upgrades/mainnet-upgrades/byzantium.md)
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.762] github.com/ava-labs/coreth/core/blockchain.go:309: - Constantinople: 0 (https://github.com/ethereum/execution-specs/blob/master/network-upgrades/mainnet-upgrades/constantinople.md)
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.762] github.com/ava-labs/coreth/core/blockchain.go:309: - Petersburg: 0 (https://github.com/ethereum/execution-specs/blob/master/network-upgrades/mainnet-upgrades/petersburg.md)
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.762] github.com/ava-labs/coreth/core/blockchain.go:309: - Istanbul: 0 (https://github.com/ethereum/execution-specs/blob/master/network-upgrades/mainnet-upgrades/istanbul.md)
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.762] github.com/ava-labs/coreth/core/blockchain.go:309: - Muir Glacier: 0 (https://github.com/ethereum/execution-specs/blob/master/network-upgrades/mainnet-upgrades/muir-glacier.md)
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.762] github.com/ava-labs/coreth/core/blockchain.go:309: - Apricot Phase 1 Timestamp: 0 (https://github.com/ava-labs/avalanchego/releases/tag/v1.3.0)
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.762] github.com/ava-labs/coreth/core/blockchain.go:309: - Apricot Phase 2 Timestamp: 0 (https://github.com/ava-labs/avalanchego/releases/tag/v1.4.0)
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.762] github.com/ava-labs/coreth/core/blockchain.go:309: - Apricot Phase 3 Timestamp: 0 (https://github.com/ava-labs/avalanchego/releases/tag/v1.5.0)
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.762] github.com/ava-labs/coreth/core/blockchain.go:309: - Apricot Phase 4 Timestamp: 0 (https://github.com/ava-labs/avalanchego/releases/tag/v1.6.0)
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.762] github.com/ava-labs/coreth/core/blockchain.go:309: - Apricot Phase 5 Timestamp: 0 (https://github.com/ava-labs/avalanchego/releases/tag/v1.7.0)
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.762] github.com/ava-labs/coreth/core/blockchain.go:309: - Apricot Phase P6 Timestamp 0 (https://github.com/ava-labs/avalanchego/releases/tag/v1.8.0)
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.762] github.com/ava-labs/coreth/core/blockchain.go:309: - Apricot Phase 6 Timestamp: 0 (https://github.com/ava-labs/avalanchego/releases/tag/v1.8.0)
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.762] github.com/ava-labs/coreth/core/blockchain.go:309: - Apricot Phase Post-6 Timestamp: 0 (https://github.com/ava-labs/avalanchego/releases/tag/v1.8.0
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.762] github.com/ava-labs/coreth/core/blockchain.go:309: - Banff Timestamp: 0 (https://github.com/ava-labs/avalanchego/releases/tag/v1.9.0)
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.762] github.com/ava-labs/coreth/core/blockchain.go:309: - Cortina Timestamp: 0 (https://github.com/ava-labs/avalanchego/releases/tag/v1.10.0)
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.762] github.com/ava-labs/coreth/core/blockchain.go:309: - DUpgrade Timestamp (https://github.com/ava-labs/avalanchego/releases/tag/v1.11.0)
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.762] github.com/ava-labs/coreth/core/blockchain.go:309:
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.762] github.com/ava-labs/coreth/core/blockchain.go:309:
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.762] github.com/ava-labs/coreth/core/blockchain.go:311: ---------------------------------------------------------------------------------------------------------------------------------------------------------
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.762] github.com/ava-labs/coreth/core/blockchain.go:312:
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.764] github.com/ava-labs/coreth/core/blockchain.go:710: Loaded most recent local header number=0 hash=b81c22..0e6bb9 age=54y2mo2w
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.764] github.com/ava-labs/coreth/core/blockchain.go:711: Loaded most recent local full block number=0 hash=b81c22..0e6bb9 age=54y2mo2w
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.764] github.com/ava-labs/coreth/core/blockchain.go:1722: Loaded Acceptor tip hash=000000..000000
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.764] github.com/ava-labs/coreth/core/blockchain.go:1730: Skipping state reprocessing root=3cbfcc..68c8b4
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.764] github.com/ava-labs/coreth/core/blockchain.go:544: Not warming accepted cache because there are no accepted blocks
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.764] github.com/ava-labs/coreth/core/blockchain.go:567: Starting Acceptor queue length=64
+[0;0m[1;34m[node2] DEBUG[06-11|00:50:35.764] github.com/ava-labs/coreth/core/tx_pool.go:1408: Reinjecting stale transactions count=0
+[0;0m[1;34m[node2] WARN [06-11|00:50:35.765] github.com/ava-labs/coreth/core/rawdb/accessors_metadata.go:111: Error reading unclean shutdown markers error="not found"
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.765] github.com/ava-labs/coreth/core/tx_pool.go:505: Transaction pool price threshold updated price=470,000,000,000
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.765] github.com/ava-labs/coreth/core/tx_pool.go:505: Transaction pool price threshold updated price=225,000,000,000
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.765] github.com/ava-labs/coreth/core/tx_pool.go:505: Transaction pool price threshold updated price=0
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.765] github.com/ava-labs/coreth/plugin/evm/atomic_tx_repository.go:115: Initializing atomic transaction repository from scratch
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.765] github.com/ava-labs/coreth/plugin/evm/atomic_tx_repository.go:191: Completed atomic transaction repository migration lastAcceptedHeight=0 duration="131.722µs"
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.766] github.com/ava-labs/coreth/plugin/evm/atomic_tx_repository.go:438: atomic tx repository RepairForBonusBlocks complete repairedEntries=0
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.766] github.com/ava-labs/coreth/plugin/evm/atomic_backend.go:132: initializing atomic trie lastCommittedHeight=0
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.766] github.com/ava-labs/coreth/plugin/evm/atomic_backend.go:210: finished initializing atomic trie lastAcceptedHeight=0 lastAcceptedAtomicRoot=56e81f..63b421 heightsIndexed=0 lastCommittedRoot=56e81f..63b421 lastCommittedHeight=0 time="64.664µs"
+[0;0m[1;34m[node2] [06-11|00:50:35.767] INFO proposervm/vm.go:356 block height index was successfully verified
+[0;0m[1;34m[node2] [06-11|00:50:35.771] INFO snowman/transitive.go:89 initializing consensus engine
+[0;0m[1;34m[node2] INFO [06-11|00:50:35.772] github.com/ava-labs/coreth/plugin/evm/vm.go:1171: Enabled APIs: eth, eth-filter, net, web3, internal-eth, internal-blockchain, internal-transaction, internal-account, avax
+[0;0m[1;34m[node2] DEBUG[06-11|00:50:35.772] github.com/ava-labs/coreth/rpc/websocket.go:104: Allowed origin(s) for WS RPC interface [*]
+[0;0m[1;34m[node2] [06-11|00:50:35.773] INFO server/server.go:269 adding route {"url": "/ext/bc/23JVJWr6QVJi91LuVNh8e2Cpd4vFe9ApVBzJf5yfq8hAFnd76Z", "endpoint": "/avax"}
+[0;0m[1;34m[node2] [06-11|00:50:35.773] INFO server/server.go:269 adding route {"url": "/ext/bc/23JVJWr6QVJi91LuVNh8e2Cpd4vFe9ApVBzJf5yfq8hAFnd76Z", "endpoint": "/rpc"}
+[0;0m[1;34m[node2] [06-11|00:50:35.773] INFO server/server.go:269 adding route {"url": "/ext/bc/23JVJWr6QVJi91LuVNh8e2Cpd4vFe9ApVBzJf5yfq8hAFnd76Z", "endpoint": "/ws"}
+[0;0m[1;34m[node2] [06-11|00:50:35.773] INFO indexer/index.go:100 created new index {"nextAcceptedIndex": 0}
+[0;0m[1;34m[node2] [06-11|00:50:35.773] INFO server/server.go:308 adding route {"url": "/ext/index/C", "endpoint": "/block"}
+[0;0m[1;34m[node2] [06-11|00:50:35.774] INFO syncer/state_syncer.go:385 starting state sync
+[0;0m[1;34m[node2] [06-11|00:50:35.774] INFO chains/manager.go:319 creating chain {"subnetID": "11111111111111111111111111111111LpoYY", "chainID": "qzfF3A11KzpcHkkqznEyQgupQrCNS6WV6fTUTwZpEKqhj1QE7", "vmID": "jvYyfQTxGMJLuGWa55kdP2p2zSUYsQ5Raupu4TW34ZAUBAbtq"}
+[0;0m[1;34m[node2] DEBUG[06-11|00:50:35.774] github.com/ava-labs/coreth/peer/network.go:486: adding new peer nodeID=NodeID-MFrZFVCXPv5iCn6M9K6XduxGTYp891xXZ
+[0;0m[1;34m[node2] DEBUG[06-11|00:50:35.774] github.com/ava-labs/coreth/peer/network.go:496: skipping registering self as peer
+[0;0m[1;34m[node2] DEBUG[06-11|00:50:35.774] github.com/ava-labs/coreth/peer/network.go:486: adding new peer nodeID=NodeID-7Xhw2mDxuDS44j42TCB6U5579esbSt3Lg
+[0;0m[1;34m[node2] [06-11|00:50:35.777] INFO avm/vm.go:636 initializing genesis asset {"txID": "BUuypiq2wyuLMvyhzFXcPyxPMCgSp7eeDohhQRqTChoBjKziC"}
+[0;0m[1;34m[node2] [06-11|00:50:35.777] INFO avm/vm.go:619 fee asset is established {"alias": "AVAX", "assetID": "BUuypiq2wyuLMvyhzFXcPyxPMCgSp7eeDohhQRqTChoBjKziC"}
+[0;0m[1;34m[node2] [06-11|00:50:35.777] INFO avm/vm.go:275 address transaction indexing is disabled
+[0;0m[1;34m[node2] [06-11|00:50:35.778] INFO chains/manager.go:756 creating proposervm wrapper {"activationTime": "[12-05|05:00:00.000]", "minPChainHeight": 0, "minBlockDelay": "1s"}
+[0;0m[1;34m[node2] [06-11|00:50:35.782] INFO snowman/transitive.go:89 initializing consensus engine
+[0;0m[1;34m[node2] [06-11|00:50:35.783] INFO server/server.go:269 adding route {"url": "/ext/bc/qzfF3A11KzpcHkkqznEyQgupQrCNS6WV6fTUTwZpEKqhj1QE7", "endpoint": ""}
+[0;0m[1;34m[node2] [06-11|00:50:35.783] INFO server/server.go:269 adding route {"url": "/ext/bc/qzfF3A11KzpcHkkqznEyQgupQrCNS6WV6fTUTwZpEKqhj1QE7", "endpoint": "/wallet"}
+[0;0m[1;34m[node2] [06-11|00:50:35.783] INFO server/server.go:269 adding route {"url": "/ext/bc/qzfF3A11KzpcHkkqznEyQgupQrCNS6WV6fTUTwZpEKqhj1QE7", "endpoint": "/events"}
+[0;0m[1;34m[node2] [06-11|00:50:35.783] INFO indexer/index.go:100 created new index {"nextAcceptedIndex": 0}
+[0;0m[1;34m[node2] [06-11|00:50:35.783] INFO server/server.go:308 adding route {"url": "/ext/index/X", "endpoint": "/block"}
+[0;0m[1;34m[node2] [06-11|00:50:35.784] INFO indexer/index.go:100 created new index {"nextAcceptedIndex": 0}
+[0;0m[1;34m[node2] [06-11|00:50:35.784] INFO server/server.go:308 adding route {"url": "/ext/index/X", "endpoint": "/vtx"}
+[0;0m[1;34m[node2] [06-11|00:50:35.784] INFO indexer/index.go:100 created new index {"nextAcceptedIndex": 0}
+[0;0m[1;34m[node2] [06-11|00:50:35.784] INFO server/server.go:308 adding route {"url": "/ext/index/X", "endpoint": "/tx"}
+[0;0m[1;34m[node2] [06-11|00:50:35.784] INFO bootstrap/bootstrapper.go:290 starting bootstrap
+[0;0m[1;34m[node2] [06-11|00:50:35.784] INFO bootstrap/bootstrapper.go:347 accepted stop vertex {"vtxID": "sj8adpSGCc7k7aWFNkiugYvUSHGq9xUvJPb8VzdVPXv9u2b5X"}
+[0;0m[1;34m[node2] [06-11|00:50:35.785] INFO bootstrap/bootstrapper.go:571 executing transactions
+[0;0m[1;34m[node2] [06-11|00:50:35.785] INFO queue/jobs.go:224 executed operations {"numExecuted": 0}
+[0;0m[1;34m[node2] [06-11|00:50:35.785] INFO bootstrap/bootstrapper.go:588 executing vertices
+[0;0m[1;34m[node2] [06-11|00:50:35.785] INFO queue/jobs.go:224 executed operations {"numExecuted": 0}
+[0;0m[1;34m[node2] [06-11|00:50:35.786] INFO bootstrap/bootstrapper.go:115 starting bootstrapper
+[0;0m[0;37m[node3] [06-11|00:50:35.793] WARN app/app.go:153 P2P IP is private, you will not be publicly discoverable {"ip": "127.0.0.1"}
+[0;0m[0;37m[node3] [06-11|00:50:35.794] INFO node/node.go:1251 initializing node {"version": "avalanche/1.10.1", "nodeID": "NodeID-NFBbbJ4qCmNaCzeW7sxErhvWqvEQMnYcN", "nodePOP": {"publicKey":"0xb20ab07ea5cf8b77ab50f2071a6f1d2aab693c8bd89761430cd29de9fa0dbae83a32c7697d59ff1b06995b1596c16fa6","proofOfPossession":"0xa113145564d7ac540fade2526938fbd33233957901111328c86c4cbe7ed25f678173d95c54b3342fd7b723c3ed813f2b04fecf4a317205ce65638bb34bb58bb6746e74c63e6cbe5cb25c103b290ed270146b756d3901c8b0f99d083a44572c79"}, "providedFlags": {"api-admin-enabled":true,"api-ipcs-enabled":true,"bootstrap-ids":"NodeID-7Xhw2mDxuDS44j42TCB6U5579esbSt3Lg,NodeID-MFrZFVCXPv5iCn6M9K6XduxGTYp891xXZ","bootstrap-ips":"[::1]:9651,[::1]:9653","chain-config-dir":"/tmp/network-runner-root-data_20230611_005034/node3/chainConfigs","consensus-app-concurrency":"512","consensus-on-accept-gossip-peer-size":"10","consensus-on-accept-gossip-validator-size":"10","data-dir":"/tmp/network-runner-root-data_20230611_005034/node3","db-dir":"/tmp/network-runner-root-data_20230611_005034/node3/db","genesis":"/tmp/network-runner-root-data_20230611_005034/node3/genesis.json","health-check-frequency":"2s","http-port":"9654","index-enabled":true,"log-dir":"/tmp/network-runner-root-data_20230611_005034/node3/logs","log-display-level":"info","log-level":"DEBUG","network-compression-type":"none","network-id":"1337","network-max-reconnect-delay":"1s","network-peer-list-gossip-frequency":"250ms","plugin-dir":"/tmp/avalanchego-v1.10.1/plugins","proposervm-use-current-height":true,"public-ip":"127.0.0.1","snow-mixed-query-num-push-vdr":"10","staking-port":"9655","staking-signer-key-file":"/tmp/network-runner-root-data_20230611_005034/node3/signer.key","staking-tls-cert-file":"/tmp/network-runner-root-data_20230611_005034/node3/staking.crt","staking-tls-key-file":"/tmp/network-runner-root-data_20230611_005034/node3/staking.key","subnet-config-dir":"/tmp/network-runner-root-data_20230611_005034/node3/subnetConfigs","throttler-inbound-at-large-alloc-size":"10737418240","throttler-inbound-bandwidth-max-burst-size":"1073741824","throttler-inbound-bandwidth-refill-rate":"1073741824","throttler-inbound-cpu-validator-alloc":"100000","throttler-inbound-disk-validator-alloc":"1.073741824e+13","throttler-inbound-node-max-processing-msgs":"100000","throttler-inbound-validator-alloc-size":"10737418240","throttler-outbound-at-large-alloc-size":"10737418240","throttler-outbound-validator-alloc-size":"10737418240"}, "config": {"httpConfig":{"readTimeout":30000000000,"readHeaderTimeout":30000000000,"writeHeaderTimeout":30000000000,"idleTimeout":120000000000,"apiConfig":{"authConfig":{"apiRequireAuthToken":false},"indexerConfig":{"indexAPIEnabled":true,"indexAllowIncomplete":false},"ipcConfig":{"ipcAPIEnabled":true,"ipcPath":"/tmp","ipcDefaultChainIDs":null},"adminAPIEnabled":true,"infoAPIEnabled":true,"keystoreAPIEnabled":false,"metricsAPIEnabled":true,"healthAPIEnabled":true},"httpHost":"127.0.0.1","httpPort":9654,"httpsEnabled":false,"apiAllowedOrigins":["*"],"shutdownTimeout":10000000000,"shutdownWait":0},"ipConfig":{"ip":{"ip":"127.0.0.1","port":9655},"ipResolutionFrequency":300000000000,"attemptedNATTraversal":false},"stakingConfig":{"uptimeRequirement":0.8,"minValidatorStake":2000000000000,"maxValidatorStake":3000000000000000,"minDelegatorStake":25000000000,"minDelegationFee":20000,"minStakeDuration":86400000000000,"maxStakeDuration":31536000000000000,"rewardConfig":{"maxConsumptionRate":120000,"minConsumptionRate":100000,"mintingPeriod":31536000000000000,"supplyCap":720000000000000000},"enableStaking":true,"disabledStakingWeight":100,"stakingKeyPath":"/tmp/network-runner-root-data_20230611_005034/node3/staking.key","stakingCertPath":"/tmp/network-runner-root-data_20230611_005034/node3/staking.crt","stakingSignerPath":"/tmp/network-runner-root-data_20230611_005034/node3/signer.key"},"txFeeConfig":{"txFee":1000000,"createAssetTxFee":1000000,"createSubnetTxFee":100000000,"transformSubnetTxFee":100000000,"createBlockchainTxFee":100000000,"addPrimaryNetworkValidatorFee":0,"addPrimaryNetworkDelegatorFee":0,"addSubnetValidatorFee":1000000,"addSubnetDelegatorFee":1000000},"stateSyncConfig":{"stateSyncIDs":null,"stateSyncIPs":null},"bootstrapConfig":{"retryBootstrap":true,"retryBootstrapWarnFrequency":50,"bootstrapBeaconConnectionTimeout":60000000000,"bootstrapAncestorsMaxContainersSent":2000,"bootstrapAncestorsMaxContainersReceived":2000,"bootstrapMaxTimeGetAncestors":50000000,"bootstrapIDs":["NodeID-7Xhw2mDxuDS44j42TCB6U5579esbSt3Lg","NodeID-MFrZFVCXPv5iCn6M9K6XduxGTYp891xXZ"],"bootstrapIPs":[{"ip":"::1","port":9651},{"ip":"::1","port":9653}]},"databaseConfig":{"path":"/tmp/network-runner-root-data_20230611_005034/node3/db/network-1337","name":"leveldb"},"avaxAssetID":"BUuypiq2wyuLMvyhzFXcPyxPMCgSp7eeDohhQRqTChoBjKziC","networkID":1337,"healthCheckFreq":2000000000,"networkConfig":{"healthConfig":{"minConnectedPeers":1,"maxTimeSinceMsgReceived":60000000000,"maxTimeSinceMsgSent":60000000000,"maxPortionSendQueueBytesFull":0.9,"maxSendFailRate":0.9,"sendFailRateHalflife":10000000000},"peerListGossipConfig":{"peerListNumValidatorIPs":15,"peerListValidatorGossipSize":20,"peerListNonValidatorGossipSize":0,"peerListPeersGossipSize":10,"peerListGossipFreq":250000000},"timeoutConfigs":{"pingPongTimeout":30000000000,"readHandshakeTimeout":15000000000},"delayConfig":{"initialReconnectDelay":1000000000,"maxReconnectDelay":1000000000},"throttlerConfig":{"inboundConnUpgradeThrottlerConfig":{"upgradeCooldown":10000000000,"maxRecentConnsUpgraded":2560},"inboundMsgThrottlerConfig":{"byteThrottlerConfig":{"vdrAllocSize":10737418240,"atLargeAllocSize":10737418240,"nodeMaxAtLargeBytes":2097152},"bandwidthThrottlerConfig":{"bandwidthRefillRate":1073741824,"bandwidthMaxBurstRate":1073741824},"cpuThrottlerConfig":{"maxRecheckDelay":5000000000},"diskThrottlerConfig":{"maxRecheckDelay":5000000000},"maxProcessingMsgsPerNode":100000},"outboundMsgThrottlerConfig":{"vdrAllocSize":10737418240,"atLargeAllocSize":10737418240,"nodeMaxAtLargeBytes":2097152},"maxInboundConnsPerSec":256},"proxyEnabled":false,"proxyReadHeaderTimeout":3000000000,"dialerConfig":{"throttleRps":50,"connectionTimeout":30000000000},"tlsKeyLogFile":"","namespace":"","myNodeID":"NodeID-111111111111111111116DBWJs","myIP":null,"networkID":0,"maxClockDifference":60000000000,"pingFrequency":22500000000,"allowPrivateIPs":true,"compressionType":"none","uptimeMetricFreq":30000000000,"requireValidatorToConnect":false,"maximumInboundMessageTimeout":10000000000,"peerReadBufferSize":8192,"peerWriteBufferSize":8192},"adaptiveTimeoutConfig":{"initialTimeout":5000000000,"minimumTimeout":2000000000,"maximumTimeout":10000000000,"timeoutCoefficient":2,"timeoutHalflife":300000000000},"benchlistConfig":{"threshold":10,"minimumFailingDuration":150000000000,"duration":900000000000,"maxPortion":0.08333333333333333},"profilerConfig":{"dir":"/tmp/network-runner-root-data_20230611_005034/node3/profiles","enabled":false,"freq":900000000000,"maxNumFiles":5},"loggingConfig":{"maxSize":8,"maxFiles":7,"maxAge":0,"directory":"/tmp/network-runner-root-data_20230611_005034/node3/logs","compress":false,"disableWriterDisplaying":false,"logLevel":"DEBUG","displayLevel":"INFO","logFormat":"PLAIN"},"pluginDir":"/tmp/avalanchego-v1.10.1/plugins","fdLimit":32768,"meterVMEnabled":true,"routerHealthConfig":{"maxDropRate":1,"maxDropRateHalflife":10000000000,"maxOutstandingRequests":1024,"maxOutstandingDuration":300000000000,"maxRunTimeRequests":10000000000},"consensusShutdownTimeout":30000000000,"consensusGossipFreq":10000000000,"consensusAppConcurrency":512,"trackedSubnets":[],"subnetConfigs":{"11111111111111111111111111111111LpoYY":{"gossipAcceptedFrontierValidatorSize":0,"gossipAcceptedFrontierNonValidatorSize":0,"gossipAcceptedFrontierPeerSize":15,"gossipOnAcceptValidatorSize":10,"gossipOnAcceptNonValidatorSize":0,"gossipOnAcceptPeerSize":10,"appGossipValidatorSize":10,"appGossipNonValidatorSize":0,"appGossipPeerSize":0,"validatorOnly":false,"allowedNodes":null,"consensusParameters":{"k":20,"alpha":15,"betaVirtuous":20,"betaRogue":20,"concurrentRepolls":4,"optimalProcessing":10,"maxOutstandingItems":256,"maxItemProcessingTime":30000000000,"mixedQueryNumPushVdr":10,"mixedQueryNumPushNonVdr":0},"proposerMinBlockDelay":1000000000,"minPercentConnectedStakeHealthy":0}},"chainAliases":null,"systemTrackerProcessingHalflife":15000000000,"systemTrackerFrequency":500000000,"systemTrackerCPUHalflife":15000000000,"systemTrackerDiskHalflife":60000000000,"cpuTargeterConfig":{"vdrAlloc":100000,"maxNonVdrUsage":44.800000000000004,"maxNonVdrNodeUsage":7},"diskTargeterConfig":{"vdrAlloc":10737418240000,"maxNonVdrUsage":1073741824000,"maxNonVdrNodeUsage":1073741824000},"requiredAvailableDiskSpace":536870912,"warningThresholdAvailableDiskSpace":1073741824,"traceConfig":{"exporterConfig":{"type":"unknown","endpoint":"","headers":null,"insecure":false},"enabled":false,"traceSampleRate":0},"minPercentConnectedStakeHealthy":{"11111111111111111111111111111111LpoYY":0.8},"useCurrentHeight":true,"chainDataDir":"/tmp/network-runner-root-data_20230611_005034/node3/chainData"}}
+[0;0m[0;37m[node3] [06-11|00:50:35.794] INFO node/node.go:582 initializing API server
+[0;0m[0;37m[node3] [06-11|00:50:35.794] INFO server/server.go:147 API created {"allowedOrigins": ["*"]}
+[0;0m[0;37m[node3] [06-11|00:50:35.795] INFO node/node.go:912 initializing metrics API
+[0;0m[0;37m[node3] [06-11|00:50:35.795] INFO server/server.go:308 adding route {"url": "/ext/metrics", "endpoint": ""}
+[0;0m[0;37m[node3] [06-11|00:50:35.795] INFO leveldb/db.go:208 creating leveldb {"config": {"blockCacheCapacity":12582912,"blockSize":0,"compactionExpandLimitFactor":0,"compactionGPOverlapsFactor":0,"compactionL0Trigger":0,"compactionSourceLimitFactor":0,"compactionTableSize":0,"compactionTableSizeMultiplier":0,"compactionTableSizeMultiplierPerLevel":null,"compactionTotalSize":0,"compactionTotalSizeMultiplier":0,"disableSeeksCompaction":true,"openFilesCacheCapacity":1024,"writeBuffer":6291456,"filterBitsPerKey":10,"maxManifestFileSize":9223372036854775807,"metricUpdateFrequency":10000000000}}
+[0;0m[0;37m[node3] [06-11|00:50:35.814] INFO node/node.go:452 initializing database {"dbVersion": "v1.4.5"}
+[0;0m[0;37m[node3] [06-11|00:50:35.814] INFO node/node.go:869 initializing keystore
+[0;0m[0;37m[node3] [06-11|00:50:35.814] INFO node/node.go:877 skipping keystore API initialization because it has been disabled
+[0;0m[0;37m[node3] [06-11|00:50:35.814] INFO node/node.go:861 initializing SharedMemory
+[0;0m[0;37m[node3] [06-11|00:50:35.818] INFO node/node.go:232 initializing networking {"currentNodeIP": "127.0.0.1:9655"}
+[0;0m[0;37m[node3] [06-11|00:50:35.819] INFO node/node.go:1032 initializing Health API
+[0;0m[0;37m[node3] [06-11|00:50:35.820] INFO server/server.go:308 adding route {"url": "/ext/health", "endpoint": ""}
+[0;0m[0;37m[node3] [06-11|00:50:35.820] INFO server/server.go:308 adding route {"url": "/ext/health", "endpoint": "/readiness"}
+[0;0m[0;37m[node3] [06-11|00:50:35.820] INFO server/server.go:308 adding route {"url": "/ext/health", "endpoint": "/health"}
+[0;0m[0;37m[node3] [06-11|00:50:35.820] INFO server/server.go:308 adding route {"url": "/ext/health", "endpoint": "/liveness"}
+[0;0m[0;37m[node3] [06-11|00:50:35.820] INFO node/node.go:642 adding the default VM aliases
+[0;0m[0;37m[node3] [06-11|00:50:35.821] INFO node/node.go:763 initializing VMs
+[0;0m[0;37m[node3] [06-11|00:50:35.821] INFO server/server.go:308 adding route {"url": "/ext/vm/rWhpuQPF1kb72esV2momhMuTYGkEb1oL29pt2EBXWmSy4kxnT", "endpoint": ""}
+[0;0m[0;37m[node3] [06-11|00:50:35.821] INFO server/server.go:308 adding route {"url": "/ext/vm/jvYyfQTxGMJLuGWa55kdP2p2zSUYsQ5Raupu4TW34ZAUBAbtq", "endpoint": ""}
+[0;0m[0;37m[node3] [06-11|00:50:35.821] INFO server/server.go:308 adding route {"url": "/ext/vm/mgj786NP7uDwBCcq6YwThhaN8FLyybkCa4zBWTQbNgmK6k9A6", "endpoint": "/rpc"}
+[0;0m[06-11|00:50:35.823] INFO local/network.go:587 adding node {"node-name": "node4", "node-dir": "/tmp/network-runner-root-data_20230611_005034/node4", "log-dir": "/tmp/network-runner-root-data_20230611_005034/node4/logs", "db-dir": "/tmp/network-runner-root-data_20230611_005034/node4/db", "p2p-port": 9657, "api-port": 9656}
+[06-11|00:50:35.824] DEBUG local/network.go:597 starting node {"name": "node4", "binaryPath": "/tmp/avalanchego-v1.10.1/avalanchego", "args": ["--http-port=9656", "--staking-signer-key-file=/tmp/network-runner-root-data_20230611_005034/node4/signer.key", "--bootstrap-ids=NodeID-7Xhw2mDxuDS44j42TCB6U5579esbSt3Lg,NodeID-MFrZFVCXPv5iCn6M9K6XduxGTYp891xXZ,NodeID-NFBbbJ4qCmNaCzeW7sxErhvWqvEQMnYcN", "--throttler-outbound-validator-alloc-size=10737418240", "--network-id=1337", "--throttler-outbound-at-large-alloc-size=10737418240", "--staking-port=9657", "--plugin-dir=/tmp/avalanchego-v1.10.1/plugins", "--api-ipcs-enabled=true", "--throttler-inbound-bandwidth-refill-rate=1073741824", "--db-dir=/tmp/network-runner-root-data_20230611_005034/node4/db", "--bootstrap-ips=[::1]:9651,[::1]:9653,[::1]:9655", "--throttler-inbound-node-max-processing-msgs=100000", "--staking-tls-cert-file=/tmp/network-runner-root-data_20230611_005034/node4/staking.crt", "--staking-tls-key-file=/tmp/network-runner-root-data_20230611_005034/node4/staking.key", "--chain-config-dir=/tmp/network-runner-root-data_20230611_005034/node4/chainConfigs", "--network-compression-type=none", "--log-display-level=info", "--throttler-inbound-cpu-validator-alloc=100000", "--public-ip=127.0.0.1", "--consensus-app-concurrency=512", "--genesis=/tmp/network-runner-root-data_20230611_005034/node4/genesis.json", "--data-dir=/tmp/network-runner-root-data_20230611_005034/node4", "--network-max-reconnect-delay=1s", "--snow-mixed-query-num-push-vdr=10", "--throttler-inbound-validator-alloc-size=10737418240", "--network-peer-list-gossip-frequency=250ms", "--subnet-config-dir=/tmp/network-runner-root-data_20230611_005034/node4/subnetConfigs", "--api-admin-enabled=true", "--index-enabled=true", "--throttler-inbound-bandwidth-max-burst-size=1073741824", "--throttler-inbound-disk-validator-alloc=10737418240000", "--consensus-on-accept-gossip-validator-size=10", "--log-dir=/tmp/network-runner-root-data_20230611_005034/node4/logs", "--health-check-frequency=2s", "--consensus-on-accept-gossip-peer-size=10", "--throttler-inbound-at-large-alloc-size=10737418240", "--proposervm-use-current-height=true", "--log-level=DEBUG"]}
+[0;37m[node3] [06-11|00:50:35.910] INFO subprocess/runtime.go:143 plugin handshake succeeded {"addr": "127.0.0.1:46279"}
+[0;0m[0;37m[node3] runtime engine: received shutdown signal: SIGTERM
+[0;0m[0;37m[node3] vm server: graceful termination success
+[0;0m[0;37m[node3] [06-11|00:50:35.916] INFO subprocess/runtime.go:111 stdout collector shutdown
+[0;0m[0;37m[node3] [06-11|00:50:35.916] INFO subprocess/runtime.go:124 stderr collector shutdown
+[0;0m[0;37m[node3] [06-11|00:50:35.992] INFO subprocess/runtime.go:143 plugin handshake succeeded {"addr": "127.0.0.1:33507"}
+[0;0m[0;37m[node3] [06-11|00:50:35.994] INFO node/node.go:935 initializing admin API
+[0;0m[0;37m[node3] [06-11|00:50:35.995] INFO server/server.go:308 adding route {"url": "/ext/admin", "endpoint": ""}
+[0;0m[0;37m[node3] [06-11|00:50:35.995] INFO node/node.go:984 initializing info API
+[0;0m[0;37m[node3] [06-11|00:50:35.997] INFO server/server.go:308 adding route {"url": "/ext/info", "endpoint": ""}
+[0;0m[0;37m[node3] [06-11|00:50:35.997] WARN node/node.go:1138 initializing deprecated ipc API
+[0;0m[0;37m[node3] [06-11|00:50:35.997] INFO server/server.go:308 adding route {"url": "/ext/ipcs", "endpoint": ""}
+[0;0m[0;37m[node3] [06-11|00:50:35.997] INFO node/node.go:1148 initializing chain aliases
+[0;0m[0;37m[node3] [06-11|00:50:35.997] INFO node/node.go:1175 initializing API aliases
+[0;0m[0;37m[node3] [06-11|00:50:35.998] INFO node/node.go:957 skipping profiler initialization because it has been disabled
+[0;0m[0;37m[node3] [06-11|00:50:35.998] INFO node/node.go:561 initializing chains
+[0;0m[0;37m[node3] [06-11|00:50:35.998] INFO chains/manager.go:319 creating chain {"subnetID": "11111111111111111111111111111111LpoYY", "chainID": "11111111111111111111111111111111LpoYY", "vmID": "rWhpuQPF1kb72esV2momhMuTYGkEb1oL29pt2EBXWmSy4kxnT"}
+[0;0m[0;37m[node3] [06-11|00:50:36.000] INFO chains/manager.go:1102 creating proposervm wrapper {"activationTime": "[12-05|05:00:00.000]", "minPChainHeight": 0, "minBlockDelay": "1s"}
+[0;0m[0;37m[node3] [06-11|00:50:36.003] INFO platformvm/vm.go:228 initializing last accepted {"blkID": "2EYLCg5YdYRx9h3g3odqDB49o35ekw6NtXqJaom7pb3Rpvmonc"}
+[0;0m[0;37m[node3] [06-11|00:50:36.005] INFO
snowman/transitive.go:89 initializing consensus engine
+[0;0m[0;37m[node3] [06-11|00:50:36.006] INFO server/server.go:269 adding route {"url": "/ext/bc/11111111111111111111111111111111LpoYY", "endpoint": ""}
+[0;0m[0;37m[node3] [06-11|00:50:36.006] INFO indexer/index.go:100 created new index {"nextAcceptedIndex": 0}
+[0;0m[0;37m[node3] [06-11|00:50:36.006] INFO server/server.go:308 adding route {"url": "/ext/index/P", "endpoint": "/block"}
+[0;0m[0;37m[node3] [06-11|00:50:36.007] INFO
bootstrap/bootstrapper.go:115 starting bootstrapper
+[0;0m[0;37m[node3] [06-11|00:50:36.007] INFO chains/manager.go:1338 starting chain creator
+[0;0m[0;37m[node3] [06-11|00:50:36.007] INFO server/server.go:184 HTTP API server listening {"host": "127.0.0.1", "port": 9654}
+[0;0m[1;34m[node2] DEBUG[06-11|00:50:36.110] github.com/ava-labs/coreth/peer/network.go:486: adding new peer nodeID=NodeID-NFBbbJ4qCmNaCzeW7sxErhvWqvEQMnYcN
+[0;0m[0;36m[node1] DEBUG[06-11|00:50:36.114] github.com/ava-labs/coreth/peer/network.go:486: adding new peer nodeID=NodeID-NFBbbJ4qCmNaCzeW7sxErhvWqvEQMnYcN
+[0;0m[0;37m[node3] [06-11|00:50:36.116] INFO common/bootstrapper.go:244 bootstrapping started syncing {"numVerticesInFrontier": 1}
+[0;0m[0;37m[node3] [06-11|00:50:36.117] INFO
bootstrap/bootstrapper.go:554 executing blocks {"numPendingJobs": 0}
+[0;0m[0;37m[node3] [06-11|00:50:36.117] INFO
queue/jobs.go:224 executed operations {"numExecuted": 0}
+[0;0m[0;37m[node3] [06-11|00:50:36.117] INFO
bootstrap/bootstrapper.go:599 waiting for the remaining chains in this subnet to finish syncing
+[0;0m[0;37m[node3] [06-11|00:50:36.117] INFO chains/manager.go:319 creating chain {"subnetID": "11111111111111111111111111111111LpoYY", "chainID": "23JVJWr6QVJi91LuVNh8e2Cpd4vFe9ApVBzJf5yfq8hAFnd76Z", "vmID": "mgj786NP7uDwBCcq6YwThhaN8FLyybkCa4zBWTQbNgmK6k9A6"}
+[0;0m[0;37m[node3] [06-11|00:50:36.118] INFO chains/manager.go:1102 creating proposervm wrapper {"activationTime": "[12-05|05:00:00.000]", "minPChainHeight": 0, "minBlockDelay": "1s"}
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.119] github.com/ava-labs/coreth/plugin/evm/vm.go:353: Initializing Coreth VM Version=v0.12.0 Config="{SnowmanAPIEnabled:false CorethAdminAPIEnabled:false CorethAdminAPIDir: EnabledEthAPIs:[eth eth-filter net web3 internal-eth internal-blockchain internal-transaction internal-account] ContinuousProfilerDir: ContinuousProfilerFrequency:15m0s ContinuousProfilerMaxFiles:5 RPCGasCap:50000000 RPCTxFeeCap:100 TrieCleanCache:512 TrieCleanJournal: TrieCleanRejournal:0s TrieDirtyCache:256 TrieDirtyCommitTarget:20 SnapshotCache:256 Preimages:false SnapshotAsync:true SnapshotVerify:false Pruning:true AcceptorQueueLimit:64 CommitInterval:4096 AllowMissingTries:false PopulateMissingTries: PopulateMissingTriesParallelism:1024 MetricsExpensiveEnabled:false LocalTxsEnabled:false TxPoolJournal:transactions.rlp TxPoolRejournal:1h0m0s TxPoolPriceLimit:1 TxPoolPriceBump:10 TxPoolAccountSlots:16 TxPoolGlobalSlots:5120 TxPoolAccountQueue:64 TxPoolGlobalQueue:1024 APIMaxDuration:0s WSCPURefillRate:0s WSCPUMaxStored:0s MaxBlocksPerRequest:0 AllowUnfinalizedQueries:false AllowUnprotectedTxs:false AllowUnprotectedTxHashes:[0xfefb2da535e927b85fe68eb81cb2e4a5827c905f78381a01ef2322aa9b0aee8e] KeystoreDirectory: KeystoreExternalSigner: KeystoreInsecureUnlockAllowed:false RemoteTxGossipOnlyEnabled:false TxRegossipFrequency:1m0s TxRegossipMaxSize:15 LogLevel:debug LogJSONFormat:false OfflinePruning:false OfflinePruningBloomFilterSize:512 OfflinePruningDataDirectory: MaxOutboundActiveRequests:16 MaxOutboundActiveCrossChainRequests:64 StateSyncEnabled: StateSyncSkipResume:false StateSyncServerTrieCache:64 StateSyncIDs: StateSyncCommitInterval:16384 StateSyncMinBlocks:300000 StateSyncRequestSize:1024 InspectDatabase:false SkipUpgradeCheck:false AcceptedCacheSize:32 TxLookupLimit:0}"
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.121] github.com/ava-labs/coreth/trie/database.go:735: Persisted trie from memory database nodes=1 size=151.00B time="22.274µs" gcnodes=0 gcsize=0.00B gctime=0s livenodes=1 livesize=0.00B
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.121] github.com/ava-labs/coreth/plugin/evm/vm.go:429: lastAccepted = 0xb81c22ceb61ecbb2efaaf4199f82a7c870850b45f41cc9490edf0e06be0e6bb9
+[0;0m[0;37m[node3] DEBUG[06-11|00:50:36.121] github.com/ava-labs/coreth/accounts/keystore/file_cache.go:100: FS scan times list="34.386µs" set=872ns diff="6.771µs"
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.121] github.com/ava-labs/coreth/eth/backend.go:134: Allocated memory caches trie clean=512.00MiB trie dirty=256.00MiB snapshot clean=256.00MiB
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.121] github.com/ava-labs/coreth/eth/backend.go:171: Initialising Ethereum protocol network=43112 dbversion=
+[0;0m[0;37m[node3] WARN [06-11|00:50:36.121] github.com/ava-labs/coreth/eth/backend.go:177: Upgrade blockchain database version from= to=8
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.121] github.com/ava-labs/coreth/core/genesis.go:176: Writing genesis to database
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.122] github.com/ava-labs/coreth/trie/database.go:735: Persisted trie from memory database nodes=1 size=151.00B time="28.983µs" gcnodes=0 gcsize=0.00B gctime=0s livenodes=1 livesize=0.00B
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.122] github.com/ava-labs/coreth/core/blockchain.go:306:
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.122] github.com/ava-labs/coreth/core/blockchain.go:307: ---------------------------------------------------------------------------------------------------------------------------------------------------------
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.122] github.com/ava-labs/coreth/core/blockchain.go:309: Chain ID: 43112
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.122] github.com/ava-labs/coreth/core/blockchain.go:309: Consensus: Dummy Consensus Engine
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.122] github.com/ava-labs/coreth/core/blockchain.go:309:
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.122] github.com/ava-labs/coreth/core/blockchain.go:309: Hard Forks:
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.122] github.com/ava-labs/coreth/core/blockchain.go:309: - Homestead: 0 (https://github.com/ethereum/execution-specs/blob/master/network-upgrades/mainnet-upgrades/homestead.md)
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.123] github.com/ava-labs/coreth/core/blockchain.go:309: - DAO Fork: 0 (https://github.com/ethereum/execution-specs/blob/master/network-upgrades/mainnet-upgrades/dao-fork.md)
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.123] github.com/ava-labs/coreth/core/blockchain.go:309: - Tangerine Whistle (EIP 150): 0 (https://github.com/ethereum/execution-specs/blob/master/network-upgrades/mainnet-upgrades/tangerine-whistle.md)
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.123] github.com/ava-labs/coreth/core/blockchain.go:309: - Spurious Dragon/1 (EIP 155): 0 (https://github.com/ethereum/execution-specs/blob/master/network-upgrades/mainnet-upgrades/spurious-dragon.md)
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.123] github.com/ava-labs/coreth/core/blockchain.go:309: - Spurious Dragon/2 (EIP 158): 0 (https://github.com/ethereum/execution-specs/blob/master/network-upgrades/mainnet-upgrades/spurious-dragon.md)
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.123] github.com/ava-labs/coreth/core/blockchain.go:309: - Byzantium: 0 (https://github.com/ethereum/execution-specs/blob/master/network-upgrades/mainnet-upgrades/byzantium.md)
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.123] github.com/ava-labs/coreth/core/blockchain.go:309: - Constantinople: 0 (https://github.com/ethereum/execution-specs/blob/master/network-upgrades/mainnet-upgrades/constantinople.md)
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.123] github.com/ava-labs/coreth/core/blockchain.go:309: - Petersburg: 0 (https://github.com/ethereum/execution-specs/blob/master/network-upgrades/mainnet-upgrades/petersburg.md)
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.123] github.com/ava-labs/coreth/core/blockchain.go:309: - Istanbul: 0 (https://github.com/ethereum/execution-specs/blob/master/network-upgrades/mainnet-upgrades/istanbul.md)
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.123] github.com/ava-labs/coreth/core/blockchain.go:309: - Muir Glacier: 0 (https://github.com/ethereum/execution-specs/blob/master/network-upgrades/mainnet-upgrades/muir-glacier.md)
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.123] github.com/ava-labs/coreth/core/blockchain.go:309: - Apricot Phase 1 Timestamp: 0 (https://github.com/ava-labs/avalanchego/releases/tag/v1.3.0)
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.123] github.com/ava-labs/coreth/core/blockchain.go:309: - Apricot Phase 2 Timestamp: 0 (https://github.com/ava-labs/avalanchego/releases/tag/v1.4.0)
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.123] github.com/ava-labs/coreth/core/blockchain.go:309: - Apricot Phase 3 Timestamp: 0 (https://github.com/ava-labs/avalanchego/releases/tag/v1.5.0)
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.123] github.com/ava-labs/coreth/core/blockchain.go:309: - Apricot Phase 4 Timestamp: 0 (https://github.com/ava-labs/avalanchego/releases/tag/v1.6.0)
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.123] github.com/ava-labs/coreth/core/blockchain.go:309: - Apricot Phase 5 Timestamp: 0 (https://github.com/ava-labs/avalanchego/releases/tag/v1.7.0)
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.123] github.com/ava-labs/coreth/core/blockchain.go:309: - Apricot Phase P6 Timestamp 0 (https://github.com/ava-labs/avalanchego/releases/tag/v1.8.0)
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.123] github.com/ava-labs/coreth/core/blockchain.go:309: - Apricot Phase 6 Timestamp: 0 (https://github.com/ava-labs/avalanchego/releases/tag/v1.8.0)
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.123] github.com/ava-labs/coreth/core/blockchain.go:309: - Apricot Phase Post-6 Timestamp: 0 (https://github.com/ava-labs/avalanchego/releases/tag/v1.8.0
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.123] github.com/ava-labs/coreth/core/blockchain.go:309: - Banff Timestamp: 0 (https://github.com/ava-labs/avalanchego/releases/tag/v1.9.0)
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.123] github.com/ava-labs/coreth/core/blockchain.go:309: - Cortina Timestamp: 0 (https://github.com/ava-labs/avalanchego/releases/tag/v1.10.0)
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.123] github.com/ava-labs/coreth/core/blockchain.go:309: - DUpgrade Timestamp (https://github.com/ava-labs/avalanchego/releases/tag/v1.11.0)
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.123] github.com/ava-labs/coreth/core/blockchain.go:309:
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.123] github.com/ava-labs/coreth/core/blockchain.go:309:
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.123] github.com/ava-labs/coreth/core/blockchain.go:311: ---------------------------------------------------------------------------------------------------------------------------------------------------------
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.123] github.com/ava-labs/coreth/core/blockchain.go:312:
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.125] github.com/ava-labs/coreth/core/blockchain.go:710: Loaded most recent local header number=0 hash=b81c22..0e6bb9 age=54y2mo2w
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.125] github.com/ava-labs/coreth/core/blockchain.go:711: Loaded most recent local full block number=0 hash=b81c22..0e6bb9 age=54y2mo2w
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.125] github.com/ava-labs/coreth/core/blockchain.go:1722: Loaded Acceptor tip hash=000000..000000
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.125] github.com/ava-labs/coreth/core/blockchain.go:1730: Skipping state reprocessing root=3cbfcc..68c8b4
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.125] github.com/ava-labs/coreth/core/blockchain.go:544: Not warming accepted cache because there are no accepted blocks
+[0;0m[0;37m[node3] DEBUG[06-11|00:50:36.125] github.com/ava-labs/coreth/core/tx_pool.go:1408: Reinjecting stale transactions count=0
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.125] github.com/ava-labs/coreth/core/blockchain.go:567: Starting Acceptor queue length=64
+[0;0m[0;37m[node3] WARN [06-11|00:50:36.125] github.com/ava-labs/coreth/core/rawdb/accessors_metadata.go:111: Error reading unclean shutdown markers error="not found"
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.125] github.com/ava-labs/coreth/core/tx_pool.go:505: Transaction pool price threshold updated price=470,000,000,000
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.125] github.com/ava-labs/coreth/core/tx_pool.go:505: Transaction pool price threshold updated price=225,000,000,000
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.125] github.com/ava-labs/coreth/core/tx_pool.go:505: Transaction pool price threshold updated price=0
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.126] github.com/ava-labs/coreth/plugin/evm/atomic_tx_repository.go:115: Initializing atomic transaction repository from scratch
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.126] github.com/ava-labs/coreth/plugin/evm/atomic_tx_repository.go:191: Completed atomic transaction repository migration lastAcceptedHeight=0 duration="198.267µs"
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.127] github.com/ava-labs/coreth/plugin/evm/atomic_tx_repository.go:438: atomic tx repository RepairForBonusBlocks complete repairedEntries=0
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.127] github.com/ava-labs/coreth/plugin/evm/atomic_backend.go:132: initializing atomic trie lastCommittedHeight=0
+[0;0m[0;37m[node3] INFO [06-11|00:50:36.127] github.com/ava-labs/coreth/plugin/evm/atomic_backend.go:210: finished initializing atomic trie lastAcceptedHeight=0 lastAcceptedAtomicRoot=56e81f..63b421 heightsIndexed=0 lastCommittedRoot=56e81f..63b421 lastCommittedHeight=0 time="71.764µs"
+[0;0m[0;37m[node3] [06-11|00:50:36.128] INFO