search

ava-labs / avalanchego

Go implementation of an Avalanche node.
https://avax.network
BSD 3-Clause "New" or "Revised" License
2.12k stars 670 forks source link

Archived block data cannot be obtained after block synchronization. #2249

Open presIey opened 11 months ago

presIey commented 11 months ago

Describe the bug A clear and concise description of what the bug is.

Hello, need your help! It worked fine in an older version from a few months ago, but not after a certain upgrade. Later, I created an empty folder and resynchronized it, and got a light node client with only 200G. I don't why the original block data(4.1TB) is no longer available in the new client. Obviously this 200g of data is not archived block data.

[one@104 avalanche-archive]$ pwd
/mnt/dataLvmIntel/avalanche-archive
[one@104 avalanche-archive]$ du -h --max-depth=1
219G    ./avalanche-test
3.9T    ./avalanche
4.1T    .
[one@104 avalanche-archive]$ 

[one@104 node_scripts]$ cat start_avalanchego.sh
/home/one/avalanche/avalanchego/build/avalanchego  \
        --network-id=mainnet \
        --db-dir=/mnt/dataLvmIntel/avalanche-archive/avalanche-test/db \
        --log-level=trace \
        --http-host="0.0.0.0" \
        --public-ip="░░░░" \
        --http-port=9655 \
        --staking-port=9656

[one@104 node_scripts]$ cat /home/one/.avalanchego/configs/chains/C/config.json
{
    "local-txs-enabled": true,
    "eth-apis": [
        "internal-eth",
        "internal-blockchain",
        "internal-transaction",
        "internal-tx-pool",
        "internal-debug",
        "internal-account",
        "internal-personal",
        "debug-tracer",
        "web3",
        "eth",
        "eth-filter",
        "admin",
        "net"
    ],
    "state-sync-enabled": true,
    "pruning-enabled": false,
    "preimages-enabled": true
}

[one@104 node_scripts]$ /home/one/avalanche/avalanchego/build/avalanchego --version
avalanche/1.10.15 [database=v1.4.5, rpcchainvm=30, commit=20f3580b4912f29adc602ad883e84897f0965cc1, go=1.20.10]
[one@104 node_scripts]$

To Reproduce Steps to reproduce the behavior. Start by adding the sh script to the systemd task. Expected behavior A clear and concise description of what you expected to happen. Unable to obtain archived block node data. Screenshots If applicable, add screenshots to help explain your problem.

Logs If applicable, please include the relevant logs that indicate a problem and/or the log directory of your node. By default, this can be found at ~/.avalanchego/logs/.

Nov 02 17:45:01 104 systemd[1]: Started avalancheGoArchiveClient.
Nov 02 17:45:01 104 bash[566175]: [11-02|17:45:01.665] WARN app/app.go:195 HTTP server is binding to a potentially public host. You may be vulnerable to a DoS attack if your HTTP port is publicly accessible {"host": "0.0.0.0"}
Nov 02 17:45:01 104 bash[566175]: [11-02|17:45:01.665] INFO node/node.go:1358 initializing node {"version": "avalanche/1.10.15", "nodeID": "NodeID-2pWfTRbSwGEGc9p5BB6HjrdXwqfK7GKB1", "stakingKeyType": "RSA", "nodePOP": {"publicKey":"0xac17c27a5b7a449a648fdb4da2320fea5d4a749ad52349b455602da2b6c300528f019626e5087d44da7ea7eec3bfb43d","proofOfPossession":"0x92d236a4d9e17c7fd4e15fac1de782c4bbbc3b9a316d18020929cac3e2c54dbab1056b2403354d18021574e7b9eacbc21083f64abb2bc4faa665f55227b6ae726deac6f643c18c268bb0274964b19ea67637a12401f6581cf660fea6025e40f0"}, "providedFlags": {"db-dir":"/mnt/dataLvmIntel/avalanche-archive/avalanche-test/db","http-host":"0.0.0.0","http-port":"9655","log-level":"trace","network-id":"mainnet","public-ip":"░░░░","staking-port":"9656"}, "config": {"httpConfig":{"readTimeout":30000000000,"readHeaderTimeout":30000000000,"writeHeaderTimeout":30000000000,"idleTimeout":120000000000,"apiConfig":{"authConfig":{"apiRequireAuthToken":false},"indexerConfig":{"indexAPIEnabled":false,"indexAllowIncomplete":false},"ipcConfig":{"ipcAPIEnabled":false,"ipcPath":"/tmp","ipcDefaultChainIDs":null},"adminAPIEnabled":false,"infoAPIEnabled":true,"keystoreAPIEnabled":false,"metricsAPIEnabled":true,"healthAPIEnabled":true},"httpHost":"0.0.0.0","httpPort":9655,"httpsEnabled":false,"httpAllowedOrigins":["*"],"httpAllowedHosts":["localhost"],"shutdownTimeout":10000000000,"shutdownWait":0},"ipConfig":{"ip":{"ip":"░░░░","port":9656},"ipResolutionFrequency":300000000000,"attemptedNATTraversal":false,"listenHost":""},"stakingConfig":{"uptimeRequirement":0.8,"minValidatorStake":2000000000000,"maxValidatorStake":3000000000000000,"minDelegatorStake":25000000000,"minDelegationFee":20000,"minStakeDuration":1209600000000000,"maxStakeDuration":31536000000000000,"rewardConfig":{"maxConsumptionRate":120000,"minConsumptionRate":100000,"mintingPeriod":31536000000000000,"supplyCap":720000000000000000},"sybilProtectionEnabled":true,"partialSyncPrimaryNetwork":false,"sybilProtectionDisabledWeight":100,"stakingKeyPath":"/home/one/.avalanchego/staking/staker.key","stakingCertPath":"/home/one/.avalanchego/staking/staker.crt","stakingSignerPath":"/home/one/.avalanchego/staking/signer.key"},"txFeeConfig":{"txFee":1000000,"createAssetTxFee":10000000,"createSubnetTxFee":1000000000,"transformSubnetTxFee":10000000000,"createBlockchainTxFee":1000000000,"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,"bootstrappers":[{"id":"NodeID-BQEo5Fy1FRKLbX51ejqDd14cuSXJKArH2","ip":"3.34.221.73:9651"},{"id":"NodeID-QKGoUvqcgormCoMj6yPw9isY7DX9H4mdd","ip":"18.162.161.230:9651"},{"id":"NodeID-FYv1Lb29SqMpywYXH7yNkcFAzRF2jvm3K","ip":"15.188.9.42:9651"},{"id":"NodeID-4kCLS16Wy73nt1Zm54jFZsL7Msrv3UCeJ","ip":"122.248.199.127:9651"},{"id":"NodeID-A8jypu63CWp76STwKdqP6e9hjL675kdiG","ip":"3.104.107.241:9651"}]},"databaseConfig":{"path":"/mnt/dataLvmIntel/avalanche-archive/avalanche-test/db/mainnet","name":"leveldb"},"avaxAssetID":"FvwEAhmxKfeiG8SnEvq42hc6whRyY3EFYAvebMqDNDGCgxN5Z","networkID":1,"healthCheckFreq":30000000000,"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":60000000000},"timeoutConfigs":{"pingPongTimeout":30000000000,"readHandshakeTimeout":15000000000},"delayConfig":{"initialReconnectDelay":1000000000,"maxReconnectDelay":60000000000},"throttlerConfig":{"inboundConnUpgradeThrottlerConfig":{"upgradeCooldown":10000000000,"maxRecentConnsUpgraded":2560},"inboundMsgThrottlerConfig":{"byteThrottlerConfig":{"vdrAllocSize":33554432,"atLargeAllocSize":6291456,"nodeMaxAtLargeBytes":2097152},"bandwidthThrottlerConfig":{"bandwidthRefillRate":524288,"bandwidthMaxBurstRate":2097152},"cpuThrottlerConfig":{"maxRecheckDelay":5000000000},"diskThrottlerConfig":{"maxRecheckDelay":5000000000},"maxProcessingMsgsPerNode":1024},"outboundMsgThrottlerConfig":{"vdrAllocSize":33554432,"atLargeAllocSize":33554432,"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":false,"compressionType":"zstd","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":"/home/one/.avalanchego/profiles","enabled":false,"freq":900000000000,"maxNumFiles":5},"loggingConfig":{"maxSize":8,"maxFiles":7,"maxAge":0,"directory":"/home/one/.avalanchego/logs","compress":false,"disableWriterDisplaying":false,"logLevel":"TRACE","displayLevel":"TRACE","logFormat":"PLAIN"},"pluginDir":"/home/one/.avalanchego/plugins","fdLimit":32768,"meterVMEnabled":true,"routerHealthConfig":{"maxDropRate":1,"maxDropRateHalflife":10000000000,"maxOutstandingRequests":1024,"maxOutstandingDuration":300000000000,"maxRunTimeRequests":10000000000},"consensusShutdownTimeout":60000000000,"consensusGossipFreq":10000000000,"consensusAppConcurrency":2,"trackedSubnets":[],"subnetConfigs":{"11111111111111111111111111111111LpoYY":{"gossipAcceptedFrontierValidatorSize":0,"gossipAcceptedFrontierNonValidatorSize":0,"gossipAcceptedFrontierPeerSize":15,"gossipOnAcceptValidatorSize":0,"gossipOnAcceptNonValidatorSize":0,"gossipOnAcceptPeerSize":10,"appGossipValidatorSize":10,"appGossipNonValidatorSize":0,"appGossipPeerSize":0,"validatorOnly":false,"allowedNodes":[],"consensusParameters":{"k":20,"alphaPreference":15,"alphaConfidence":15,"betaVirtuous":20,"betaRogue":20,"concurrentRepolls":4,"optimalProcessing":10,"maxOutstandingItems":256,"maxItemProcessingTime":30000000000},"proposerMinBlockDelay":1000000000,"proposerNumHistoricalBlocks":0}},"chainAliases":null,"systemTrackerProcessingHalflife":15000000000,"systemTrackerFrequency":500000000,"systemTrackerCPUHalflife":15000000000,"systemTrackerDiskHalflife":60000000000,"cpuTargeterConfig":{"vdrAlloc":32,"maxNonVdrUsage":25.6,"maxNonVdrNodeUsage":4},"diskTargeterConfig":{"vdrAlloc":1073741824000,"maxNonVdrUsage":1073741824000,"maxNonVdrNodeUsage":1073741824000},"requiredAvailableDiskSpace":536870912,"warningThresholdAvailableDiskSpace":1073741824,"traceConfig":{"exporterConfig":{"type":"unknown","endpoint":"","headers":null,"insecure":false},"enabled":false,"traceSampleRate":0,"appName":"","version":""},"useCurrentHeight":false,"chainDataDir":"/home/one/.avalanchego/chainData","processContextFilePath":"/home/one/.avalanchego/process.json"}}
Nov 02 17:45:01 104 bash[566175]: [11-02|17:45:01.666] INFO node/node.go:686 initializing API server
Nov 02 17:45:01 104 bash[566175]: [11-02|17:45:01.666] INFO server/server.go:159 API created {"allowedOrigins": ["*"]}
Nov 02 17:45:01 104 bash[566175]: [11-02|17:45:01.666] INFO node/node.go:1026 initializing metrics API
Nov 02 17:45:01 104 bash[566175]: [11-02|17:45:01.666] INFO server/server.go:245 adding route {"url": "/ext/metrics", "endpoint": ""}
Nov 02 17:45:01 104 bash[566175]: [11-02|17:45:01.666] 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}}
Nov 02 17:45:01 104 bash[566175]: [11-02|17:45:01.808] INFO node/node.go:564 initializing database {"genesisHash": "UUvXi6j7QhVvgpbKM89MP5HdrxKm9CaJeHc187TsDNf8nZdLk"}
Nov 02 17:45:01 104 bash[566175]: [11-02|17:45:01.808] INFO node/node.go:988 initializing keystore
Nov 02 17:45:01 104 bash[566175]: [11-02|17:45:01.808] INFO node/node.go:995 skipping keystore API initialization because it has been disabled
Nov 02 17:45:01 104 bash[566175]: [11-02|17:45:01.808] INFO node/node.go:980 initializing SharedMemory
Nov 02 17:45:01 104 bash[566175]: [11-02|17:45:01.821] INFO node/node.go:268 initializing networking {"currentNodeIP": "░░░░:9656"}
Nov 02 17:45:01 104 bash[566175]: [11-02|17:45:01.822] INFO node/node.go:1148 initializing Health API
Nov 02 17:45:01 104 bash[566175]: [11-02|17:45:01.822] INFO health/worker.go:111 registered new check and initialized its state to failing {"namespace": "health", "name": "network", "tags": ["application"]}
Nov 02 17:45:01 104 bash[566175]: [11-02|17:45:01.822] INFO health/worker.go:111 registered new check and initialized its state to failing {"namespace": "health", "name": "router", "tags": ["application"]}
Nov 02 17:45:01 104 bash[566175]: [11-02|17:45:01.822] INFO health/worker.go:111 registered new check and initialized its state to failing {"namespace": "health", "name": "database", "tags": ["application"]}
Nov 02 17:45:01 104 bash[566175]: [11-02|17:45:01.822] INFO health/worker.go:111 registered new check and initialized its state to failing {"namespace": "health", "name": "diskspace", "tags": ["application"]}
Nov 02 17:45:01 104 bash[566175]: [11-02|17:45:01.822] INFO server/server.go:245 adding route {"url": "/ext/health", "endpoint": ""}
Nov 02 17:45:01 104 bash[566175]: [11-02|17:45:01.822] INFO server/server.go:245 adding route {"url": "/ext/health", "endpoint": "/readiness"}
Nov 02 17:45:01 104 bash[566175]: [11-02|17:45:01.822] INFO server/server.go:245 adding route {"url": "/ext/health", "endpoint": "/health"}
Nov 02 17:45:01 104 bash[566175]: [11-02|17:45:01.822] INFO server/server.go:245 adding route {"url": "/ext/health", "endpoint": "/liveness"}
Nov 02 17:45:01 104 bash[566175]: [11-02|17:45:01.822] INFO node/node.go:764 adding the default VM aliases
Nov 02 17:45:02 104 bash[566175]: [11-02|17:45:02.010] INFO node/node.go:884 initializing VMs
Nov 02 17:45:02 104 bash[566175]: [11-02|17:45:02.010] INFO server/server.go:245 adding route {"url": "/ext/vm/rWhpuQPF1kb72esV2momhMuTYGkEb1oL29pt2EBXWmSy4kxnT", "endpoint": ""}
Nov 02 17:45:02 104 bash[566175]: [11-02|17:45:02.010] INFO server/server.go:245 adding route {"url": "/ext/vm/jvYyfQTxGMJLuGWa55kdP2p2zSUYsQ5Raupu4TW34ZAUBAbtq", "endpoint": ""}
Nov 02 17:45:02 104 bash[566175]: [11-02|17:45:02.010] INFO server/server.go:245 adding route {"url": "/ext/vm/mgj786NP7uDwBCcq6YwThhaN8FLyybkCa4zBWTQbNgmK6k9A6", "endpoint": "/rpc"}
Nov 02 17:45:02 104 bash[566175]: [11-02|17:45:02.010] INFO node/node.go:1042 skipping admin API initialization because it has been disabled
Nov 02 17:45:02 104 bash[566175]: [11-02|17:45:02.010] INFO node/node.go:1098 initializing info API
Nov 02 17:45:02 104 bash[566175]: [11-02|17:45:02.011] INFO server/server.go:245 adding route {"url": "/ext/info", "endpoint": ""}
Nov 02 17:45:02 104 bash[566175]: [11-02|17:45:02.011] INFO node/node.go:1235 skipping ipc API initialization because it has been disabled
Nov 02 17:45:02 104 bash[566175]: [11-02|17:45:02.011] INFO node/node.go:1252 initializing chain aliases
Nov 02 17:45:02 104 bash[566175]: [11-02|17:45:02.092] INFO node/node.go:1279 initializing API aliases
Nov 02 17:45:02 104 bash[566175]: [11-02|17:45:02.182] INFO node/node.go:1071 skipping profiler initialization because it has been disabled
Nov 02 17:45:02 104 bash[566175]: [11-02|17:45:02.182] INFO node/node.go:665 initializing chains
Nov 02 17:45:02 104 bash[566175]: [11-02|17:45:02.182] INFO chains/manager.go:331 creating chain {"subnetID": "11111111111111111111111111111111LpoYY", "chainID": "11111111111111111111111111111111LpoYY", "vmID": "rWhpuQPF1kb72esV2momhMuTYGkEb1oL29pt2EBXWmSy4kxnT"}
Nov 02 17:45:02 104 bash[566175]: [11-02|17:45:02.182] INFO health/worker.go:257 check started passing {"namespace": "health", "name": "diskspace", "tags": ["application"]}
Nov 02 17:45:02 104 bash[566175]: [11-02|17:45:02.182] INFO health/worker.go:257 check started passing {"namespace": "health", "name": "database", "tags": ["application"]}
Nov 02 17:45:02 104 bash[566175]: [11-02|17:45:02.182] INFO health/worker.go:257 check started passing {"namespace": "health", "name": "router", "tags": ["application"]}
Nov 02 17:45:02 104 bash[566175]: [11-02|17:45:02.183] INFO chains/manager.go:1109 creating proposervm wrapper {"activationTime": "[09-22|21:00:00.000]", "minPChainHeight": 793005, "minBlockDelay": "1s", "numHistoricalBlocks": 0}
Nov 02 17:45:02 104 bash[566175]: [11-02|17:45:02.183] INFO <P Chain> platformvm/vm.go:112 using VM execution config {"config": {"block-cache-size":67108864,"tx-cache-size":134217728,"transformed-subnet-tx-cache-size":4194304,"reward-utxos-cache-size":2048,"chain-cache-size":2048,"chain-db-cache-size":2048,"block-id-cache-size":8192,"fx-owner-cache-size":4194304,"checksums-enabled":false}}
Nov 02 17:45:07 104 bash[566175]: [11-02|17:45:07.523] INFO <P Chain> platformvm/vm.go:211 initializing last accepted {"blkID": "23J5zwyBRZN3vYHEJeKESViaEgeQVLSSJZvwaRZ93cvcNTjpNK"}
Nov 02 17:45:07 104 bash[566175]: [11-02|17:45:07.523] INFO <P Chain> platformvm/vm.go:226 state already pruned and indexed
Nov 02 17:45:07 104 bash[566175]: [11-02|17:45:07.523] INFO <P Chain> proposervm/vm.go:412 block height index was successfully verified
Nov 02 17:45:07 104 bash[566175]: [11-02|17:45:07.523] INFO <P Chain> proposervm/vm.go:264 initialized proposervm {"state": "after fork", "forkHeight": 805732, "lastAcceptedHeight": 9616796}
Nov 02 17:45:07 104 bash[566175]: [11-02|17:45:07.524] INFO <P Chain> snowman/transitive.go:98 initializing consensus engine
Nov 02 17:45:07 104 bash[566175]: [11-02|17:45:07.524] INFO health/worker.go:111 registered new check and initialized its state to failing {"namespace": "health", "name": "P", "tags": ["11111111111111111111111111111111LpoYY"]}
Nov 02 17:45:07 104 bash[566175]: [11-02|17:45:07.524] INFO server/server.go:220 adding route {"url": "/ext/bc/11111111111111111111111111111111LpoYY", "endpoint": ""}
Nov 02 17:45:07 104 bash[566175]: [11-02|17:45:07.524] INFO health/worker.go:111 registered new check and initialized its state to failing {"namespace": "readiness", "name": "bootstrapped", "tags": ["application"]}
Nov 02 17:45:07 104 bash[566175]: [11-02|17:45:07.524] INFO health/worker.go:111 registered new check and initialized its state to failing {"namespace": "health", "name": "bootstrapped", "tags": ["application"]}
Nov 02 17:45:07 104 bash[566175]: [11-02|17:45:07.524] INFO <P Chain> bootstrap/bootstrapper.go:115 starting bootstrapper
Nov 02 17:45:07 104 bash[566175]: [11-02|17:45:07.524] INFO chains/manager.go:1390 starting chain creator
Nov 02 17:45:07 104 bash[566175]: [11-02|17:45:07.524] INFO node/node.go:411 writing process context {"path": "/home/one/.avalanchego/process.json"}
Nov 02 17:45:07 104 bash[566175]: [11-02|17:45:07.533] INFO node/node.go:438 API server listening {"uri": "http://[::]:9655"}
Nov 02 17:45:15 104 bash[566175]: [11-02|17:45:15.425] INFO <P Chain> common/bootstrapper.go:268 bootstrapping started syncing {"numVerticesInFrontier": 1}
Nov 02 17:45:16 104 bash[566175]: [11-02|17:45:16.820] INFO <P Chain> bootstrap/bootstrapper.go:564 executing blocks {"numPendingJobs": 1}
Nov 02 17:45:16 104 bash[566175]: [11-02|17:45:16.820] TRACE <P Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "3iKV3XPdxhPGacyknu7q2sx8LJ5m3nMZ2WbXaCUCCEuoRXo5c", "blkHeight": 9616797}
Nov 02 17:45:16 104 bash[566175]: [11-02|17:45:16.820] TRACE <P Chain> executor/acceptor.go:266 accepted block {"blockType": "banff standard", "blkID": "Ei65MyFJJSQmno28u2ysEUXpyXzCNAyYuA8njTBrCPmcMgzWM", "height": 9616797, "parentID": "23J5zwyBRZN3vYHEJeKESViaEgeQVLSSJZvwaRZ93cvcNTjpNK", "utxoChecksum": "11111111111111111111111111111111LpoYY"}
Nov 02 17:45:16 104 bash[566175]: [11-02|17:45:16.820] INFO <P Chain> queue/jobs.go:224 executed operations {"numExecuted": 1}
Nov 02 17:45:17 104 bash[566175]: [11-02|17:45:17.993] INFO chains/manager.go:331 creating chain {"subnetID": "11111111111111111111111111111111LpoYY", "chainID": "2q9e4r6Mu3U68nU1fYjgbR6JvwrRx36CohpAX5UQxse55x1Q5", "vmID": "mgj786NP7uDwBCcq6YwThhaN8FLyybkCa4zBWTQbNgmK6k9A6"}
Nov 02 17:45:17 104 bash[566175]: [11-02|17:45:17.993] INFO chains/manager.go:1109 creating proposervm wrapper {"activationTime": "[09-22|21:00:00.000]", "minPChainHeight": 793005, "minBlockDelay": "1s", "numHistoricalBlocks": 0}
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.994] <C Chain> github.com/ava-labs/coreth/plugin/evm/vm.go:401: Initializing Coreth VM Version=v0.12.7 Config="{SnowmanAPIEnabled:false AdminAPIEnabled:false AdminAPIDir: CorethAdminAPIEnabled:false CorethAdminAPIDir: EnabledEthAPIs:[internal-eth internal-blockchain internal-transaction internal-tx-pool internal-debug internal-account internal-personal debug-tracer web3 eth eth-filter admin net] ContinuousProfilerDir: ContinuousProfilerFrequency:15m0s ContinuousProfilerMaxFiles:5 RPCGasCap:50000000 RPCTxFeeCap:100 TrieCleanCache:512 TrieCleanJournal: TrieCleanRejournal:0s TrieDirtyCache:512 TrieDirtyCommitTarget:20 SnapshotCache:256 Preimages:true SnapshotWait:false SnapshotVerify:false Pruning:false AcceptorQueueLimit:64 CommitInterval:4096 AllowMissingTries:false PopulateMissingTries:<nil> PopulateMissingTriesParallelism:1024 MetricsExpensiveEnabled:true LocalTxsEnabled:true 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 RemoteGossipOnlyEnabled:false RegossipFrequency:1m0s RegossipMaxTxs:15 RemoteTxGossipOnlyEnabled:false TxRegossipFrequency:0s TxRegossipMaxSize:0 LogLevel:info LogJSONFormat:false OfflinePruning:false OfflinePruningBloomFilterSize:512 OfflinePruningDataDirectory: MaxOutboundActiveRequests:16 MaxOutboundActiveCrossChainRequests:64 StateSyncEnabled:0xc04010f2b8 StateSyncSkipResume:false StateSyncServerTrieCache:64 StateSyncIDs: StateSyncCommitInterval:16384 StateSyncMinBlocks:300000 StateSyncRequestSize:1024 InspectDatabase:false SkipUpgradeCheck:false AcceptedCacheSize:32 TxLookupLimit:0}"
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.994] <C Chain> github.com/ava-labs/coreth/trie/triedb/hashdb/database.go:521: Persisted trie from memory database nodes=1 size=141.00B time="4.96µs" gcnodes=0 gcsize=0.00B gctime=0s livenodes=0 livesize=0.00B
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.994] "<C Chain> github.com/ava-labs/coreth/plugin/evm/vm.go:480: lastAccepted = 0x9f28582bd4897407eeb92331790983d4869fa65c11bce414b2cfbabaeabcd1b8"
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.994] <C Chain> github.com/ava-labs/coreth/eth/backend.go:135: Allocated memory caches "trie clean"=512.00MiB "trie dirty"=512.00MiB "snapshot clean"=256.00MiB
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.995] <C Chain> github.com/ava-labs/coreth/eth/backend.go:172: Initialising Ethereum protocol network=43114 dbversion=8
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.995] <C Chain> github.com/ava-labs/coreth/trie/triedb/hashdb/database.go:521: Persisted trie from memory database nodes=1 size=141.00B time="3.26µs" gcnodes=0 gcsize=0.00B gctime=0s livenodes=0 livesize=0.00B
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.995] <C Chain> github.com/ava-labs/coreth/core/blockchain.go:308:
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.995] <C Chain> github.com/ava-labs/coreth/core/blockchain.go:309: ---------------------------------------------------------------------------------------------------------------------------------------------------------
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.995] <C Chain> github.com/ava-labs/coreth/core/blockchain.go:311: Chain ID:  43114
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.995] <C Chain> github.com/ava-labs/coreth/core/blockchain.go:311: Consensus: Dummy Consensus Engine
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.995] <C Chain> github.com/ava-labs/coreth/core/blockchain.go:311:
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.995] <C Chain> github.com/ava-labs/coreth/core/blockchain.go:311: Hard Forks:
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.995] <C Chain> github.com/ava-labs/coreth/core/blockchain.go:311:  - Homestead:                   #0        (https://github.com/ethereum/execution-specs/blob/master/network-upgrades/mainnet-upgrades/homestead.md)
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.995] <C Chain> github.com/ava-labs/coreth/core/blockchain.go:311:  - DAO Fork:                    #0        (https://github.com/ethereum/execution-specs/blob/master/network-upgrades/mainnet-upgrades/dao-fork.md)
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.995] <C Chain> github.com/ava-labs/coreth/core/blockchain.go:311:  - Tangerine Whistle (EIP 150): #0        (https://github.com/ethereum/execution-specs/blob/master/network-upgrades/mainnet-upgrades/tangerine-whistle.md)
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.995] <C Chain> github.com/ava-labs/coreth/core/blockchain.go:311:  - Spurious Dragon/1 (EIP 155): #0        (https://github.com/ethereum/execution-specs/blob/master/network-upgrades/mainnet-upgrades/spurious-dragon.md)
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.995] <C Chain> github.com/ava-labs/coreth/core/blockchain.go:311:  - Spurious Dragon/2 (EIP 158): #0        (https://github.com/ethereum/execution-specs/blob/master/network-upgrades/mainnet-upgrades/spurious-dragon.md)
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.995] <C Chain> github.com/ava-labs/coreth/core/blockchain.go:311:  - Byzantium:                   #0        (https://github.com/ethereum/execution-specs/blob/master/network-upgrades/mainnet-upgrades/byzantium.md)
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.995] <C Chain> github.com/ava-labs/coreth/core/blockchain.go:311:  - Constantinople:              #0        (https://github.com/ethereum/execution-specs/blob/master/network-upgrades/mainnet-upgrades/constantinople.md)
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.995] <C Chain> github.com/ava-labs/coreth/core/blockchain.go:311:  - Petersburg:                  #0        (https://github.com/ethereum/execution-specs/blob/master/network-upgrades/mainnet-upgrades/petersburg.md)
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.995] <C Chain> github.com/ava-labs/coreth/core/blockchain.go:311:  - Istanbul:                    #0        (https://github.com/ethereum/execution-specs/blob/master/network-upgrades/mainnet-upgrades/istanbul.md)
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.995] <C Chain> github.com/ava-labs/coreth/core/blockchain.go:311:  - Muir Glacier:                #0        (https://github.com/ethereum/execution-specs/blob/master/network-upgrades/mainnet-upgrades/muir-glacier.md)
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.995] <C Chain> github.com/ava-labs/coreth/core/blockchain.go:311:  - Apricot Phase 1 Timestamp:        #0xc000564b30 (https://github.com/ava-labs/avalanchego/releases/tag/v1.3.0)
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.995] <C Chain> github.com/ava-labs/coreth/core/blockchain.go:311:  - Apricot Phase 2 Timestamp:        #0xc000564b38 (https://github.com/ava-labs/avalanchego/releases/tag/v1.4.0)
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.995] <C Chain> github.com/ava-labs/coreth/core/blockchain.go:311:  - Apricot Phase 3 Timestamp:        #0xc000564b40 (https://github.com/ava-labs/avalanchego/releases/tag/v1.5.0)
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.995] <C Chain> github.com/ava-labs/coreth/core/blockchain.go:311:  - Apricot Phase 4 Timestamp:        #0xc000564b48 (https://github.com/ava-labs/avalanchego/releases/tag/v1.6.0)
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.995] <C Chain> github.com/ava-labs/coreth/core/blockchain.go:311:  - Apricot Phase 5 Timestamp:        #0xc000564b50 (https://github.com/ava-labs/avalanchego/releases/tag/v1.7.0)
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.995] <C Chain> github.com/ava-labs/coreth/core/blockchain.go:311:  - Apricot Phase P6 Timestamp        #0xc000564b58 (https://github.com/ava-labs/avalanchego/releases/tag/v1.8.0)
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.995] <C Chain> github.com/ava-labs/coreth/core/blockchain.go:311:  - Apricot Phase 6 Timestamp:        #0xc000564b60 (https://github.com/ava-labs/avalanchego/releases/tag/v1.8.0)
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.995] <C Chain> github.com/ava-labs/coreth/core/blockchain.go:311:  - Apricot Phase Post-6 Timestamp:   #0xc000564b68 (https://github.com/ava-labs/avalanchego/releases/tag/v1.8.0
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.995] <C Chain> github.com/ava-labs/coreth/core/blockchain.go:311:  - Banff Timestamp:                  #0xc000564b70 (https://github.com/ava-labs/avalanchego/releases/tag/v1.9.0)
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.995] <C Chain> github.com/ava-labs/coreth/core/blockchain.go:311:  - Cortina Timestamp:                #0xc000564b78 (https://github.com/ava-labs/avalanchego/releases/tag/v1.10.0)
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.995] <C Chain> github.com/ava-labs/coreth/core/blockchain.go:311:  - DUpgrade Timestamp:               #<nil>    (https://github.com/ava-labs/avalanchego/releases/tag/v1.11.0)
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.995] <C Chain> github.com/ava-labs/coreth/core/blockchain.go:311:  - Cancun Timestamp:                 #<nil>    (https://github.com/ava-labs/avalanchego/releases/tag/v1.11.0)
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.995] <C Chain> github.com/ava-labs/coreth/core/blockchain.go:311:
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.995] <C Chain> github.com/ava-labs/coreth/core/blockchain.go:311:
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.995] <C Chain> github.com/ava-labs/coreth/core/blockchain.go:313: ---------------------------------------------------------------------------------------------------------------------------------------------------------
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.995] <C Chain> github.com/ava-labs/coreth/core/blockchain.go:314:
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.996] <C Chain> github.com/ava-labs/coreth/core/blockchain.go:707: Loaded most recent local header number=37,235,673 hash=9f2858..bcd1b8 age=1m6s
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.996] <C Chain> github.com/ava-labs/coreth/core/blockchain.go:708: Loaded most recent local full block number=37,235,673 hash=9f2858..bcd1b8 age=1m6s
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.996] <C Chain> github.com/ava-labs/coreth/core/blockchain.go:1751: Loaded Acceptor tip hash=9f2858..bcd1b8
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.996] <C Chain> github.com/ava-labs/coreth/core/blockchain.go:1759: Skipping state reprocessing root=2b7062..64714e
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.999] <C Chain> github.com/ava-labs/coreth/core/blockchain.go:558: Warmed accepted caches start=37,235,642 end=37,235,673 t=3.31615ms
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.999] <C Chain> github.com/ava-labs/coreth/core/blockchain.go:564: Starting Acceptor "queue length"=64
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.999] <C Chain> github.com/ava-labs/coreth/core/txpool/txpool.go:516: Transaction pool price threshold updated price=470,000,000,000
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.999] <C Chain> github.com/ava-labs/coreth/core/txpool/txpool.go:516: Transaction pool price threshold updated price=225,000,000,000
Nov 02 17:45:17 104 bash[566175]: INFO [11-02|17:45:17.999] <C Chain> github.com/ava-labs/coreth/core/txpool/txpool.go:516: Transaction pool price threshold updated price=0
Nov 02 17:45:18 104 bash[566175]: INFO [11-02|17:45:18.000] <C Chain> github.com/ava-labs/coreth/plugin/evm/atomic_backend.go:132: initializing atomic trie lastCommittedHeight=37,232,640
Nov 02 17:45:18 104 bash[566175]: INFO [11-02|17:45:18.001] <C Chain> github.com/ava-labs/coreth/plugin/evm/atomic_backend.go:207: finished initializing atomic trie lastAcceptedHeight=37,235,673 lastAcceptedAtomicRoot=5e32ab..9406e0 heightsIndexed=15 lastCommittedRoot=0b3c13..028ba4 lastCommittedHeight=37,232,640 time="934.983µs"
Nov 02 17:45:18 104 bash[566175]: [11-02|17:45:18.001] INFO <C Chain> proposervm/vm.go:412 block height index was successfully verified
Nov 02 17:45:18 104 bash[566175]: [11-02|17:45:18.001] INFO <C Chain> proposervm/vm.go:264 initialized proposervm {"state": "after fork", "forkHeight": 4717713, "lastAcceptedHeight": 37235673}
Nov 02 17:45:18 104 bash[566175]: [11-02|17:45:18.002] INFO <C Chain> snowman/transitive.go:98 initializing consensus engine
Nov 02 17:45:18 104 bash[566175]: [11-02|17:45:18.002] INFO health/worker.go:111 registered new check and initialized its state to failing {"namespace": "health", "name": "C", "tags": ["11111111111111111111111111111111LpoYY"]}
Nov 02 17:45:18 104 bash[566175]: INFO [11-02|17:45:18.003] <C Chain> github.com/ava-labs/coreth/plugin/evm/vm.go:1334: Enabled APIs: internal-eth, internal-blockchain, internal-transaction, internal-tx-pool, internal-debug, internal-account, internal-personal, debug-tracer, web3, eth, eth-filter, admin, net, avax
Nov 02 17:45:18 104 bash[566175]: [11-02|17:45:18.003] INFO server/server.go:220 adding route {"url": "/ext/bc/2q9e4r6Mu3U68nU1fYjgbR6JvwrRx36CohpAX5UQxse55x1Q5", "endpoint": "/avax"}
Nov 02 17:45:18 104 bash[566175]: [11-02|17:45:18.003] INFO server/server.go:220 adding route {"url": "/ext/bc/2q9e4r6Mu3U68nU1fYjgbR6JvwrRx36CohpAX5UQxse55x1Q5", "endpoint": "/rpc"}
Nov 02 17:45:18 104 bash[566175]: [11-02|17:45:18.003] INFO server/server.go:220 adding route {"url": "/ext/bc/2q9e4r6Mu3U68nU1fYjgbR6JvwrRx36CohpAX5UQxse55x1Q5", "endpoint": "/ws"}
Nov 02 17:45:18 104 bash[566175]: [11-02|17:45:18.054] INFO <C Chain> syncer/state_syncer.go:426 starting state sync
Nov 02 17:45:18 104 bash[566175]: [11-02|17:45:18.054] INFO chains/manager.go:331 creating chain {"subnetID": "11111111111111111111111111111111LpoYY", "chainID": "2oYMBNV4eNHyqk2fjjV5nVQLDbtmNJzq5s3qs3Lo6ftnC6FByM", "vmID": "jvYyfQTxGMJLuGWa55kdP2p2zSUYsQ5Raupu4TW34ZAUBAbtq"}
Nov 02 17:45:18 104 bash[566175]: [11-02|17:45:18.062] INFO <X Chain> avm/vm.go:550 fee asset is established {"alias": "AVAX", "assetID": "FvwEAhmxKfeiG8SnEvq42hc6whRyY3EFYAvebMqDNDGCgxN5Z"}
Nov 02 17:45:18 104 bash[566175]: [11-02|17:45:18.062] INFO <X Chain> avm/vm.go:250 address transaction indexing is disabled
Nov 02 17:45:18 104 bash[566175]: [11-02|17:45:18.062] INFO chains/manager.go:753 creating proposervm wrapper {"activationTime": "[09-22|21:00:00.000]", "minPChainHeight": 793005, "minBlockDelay": "1s", "numHistoricalBlocks": 0}
Nov 02 17:45:18 104 bash[566175]: [11-02|17:45:18.063] INFO <X Chain> snowman/transitive.go:98 initializing consensus engine
Nov 02 17:45:18 104 bash[566175]: [11-02|17:45:18.063] INFO health/worker.go:111 registered new check and initialized its state to failing {"namespace": "health", "name": "X", "tags": ["11111111111111111111111111111111LpoYY"]}
Nov 02 17:45:18 104 bash[566175]: [11-02|17:45:18.064] INFO server/server.go:220 adding route {"url": "/ext/bc/2oYMBNV4eNHyqk2fjjV5nVQLDbtmNJzq5s3qs3Lo6ftnC6FByM", "endpoint": "/wallet"}
Nov 02 17:45:18 104 bash[566175]: [11-02|17:45:18.064] INFO server/server.go:220 adding route {"url": "/ext/bc/2oYMBNV4eNHyqk2fjjV5nVQLDbtmNJzq5s3qs3Lo6ftnC6FByM", "endpoint": "/events"}
Nov 02 17:45:18 104 bash[566175]: [11-02|17:45:18.064] INFO server/server.go:220 adding route {"url": "/ext/bc/2oYMBNV4eNHyqk2fjjV5nVQLDbtmNJzq5s3qs3Lo6ftnC6FByM", "endpoint": ""}
Nov 02 17:45:18 104 bash[566175]: [11-02|17:45:18.064] INFO <X Chain> bootstrap/bootstrapper.go:301 starting bootstrap
Nov 02 17:45:18 104 bash[566175]: [11-02|17:45:18.064] INFO <X Chain> bootstrap/bootstrapper.go:588 executing transactions
Nov 02 17:45:18 104 bash[566175]: [11-02|17:45:18.064] INFO <X Chain> queue/jobs.go:224 executed operations {"numExecuted": 0}
Nov 02 17:45:18 104 bash[566175]: [11-02|17:45:18.064] INFO <X Chain> bootstrap/bootstrapper.go:605 executing vertices
Nov 02 17:45:18 104 bash[566175]: [11-02|17:45:18.064] INFO <X Chain> queue/jobs.go:224 executed operations {"numExecuted": 0}
Nov 02 17:45:18 104 bash[566175]: [11-02|17:45:18.065] INFO <X Chain> proposervm/vm.go:412 block height index was successfully verified
Nov 02 17:45:18 104 bash[566175]: [11-02|17:45:18.065] INFO <X Chain> proposervm/vm.go:264 initialized proposervm {"state": "after fork", "forkHeight": 1, "lastAcceptedHeight": 161302}
Nov 02 17:45:18 104 bash[566175]: [11-02|17:45:18.065] INFO <X Chain> bootstrap/bootstrapper.go:115 starting bootstrapper
Nov 02 17:45:18 104 bash[566175]: [11-02|17:45:18.298] INFO <X Chain> states/state.go:641 state already pruned
Nov 02 17:45:18 104 bash[566175]: [11-02|17:45:18.298] INFO <X Chain> avm/vm.go:448 state pruning finished
Nov 02 17:45:30 104 bash[566175]: [11-02|17:45:30.158] TRACE <P Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "QpSDk6hnC29Nw4w3TcU92fv1v2UQrnkqn6rdyDCRujW62J7RD", "blkHeight": 9616798}
Nov 02 17:45:30 104 bash[566175]: [11-02|17:45:30.159] TRACE <P Chain> executor/acceptor.go:266 accepted block {"blockType": "banff standard", "blkID": "dF2i7fZqCa9AUguvcznB8pvvrP1z22Kyrns79Yq2Sh9oWAnmb", "height": 9616798, "parentID": "Ei65MyFJJSQmno28u2ysEUXpyXzCNAyYuA8njTBrCPmcMgzWM", "utxoChecksum": "11111111111111111111111111111111LpoYY"}
Nov 02 17:45:30 104 bash[566175]: [11-02|17:45:30.459] INFO <C Chain> syncer/state_syncer.go:452 starting state sync
Nov 02 17:45:32 104 bash[566175]: [11-02|17:45:32.183] INFO health/worker.go:257 check started passing {"namespace": "health", "name": "network", "tags": ["application"]}
Nov 02 17:45:32 104 bash[566175]: [11-02|17:45:32.183] INFO health/worker.go:257 check started passing {"namespace": "health", "name": "X", "tags": ["11111111111111111111111111111111LpoYY"]}
Nov 02 17:45:32 104 bash[566175]: [11-02|17:45:32.183] INFO health/worker.go:257 check started passing {"namespace": "health", "name": "P", "tags": ["11111111111111111111111111111111LpoYY"]}
Nov 02 17:45:32 104 bash[566175]: [11-02|17:45:32.183] INFO health/worker.go:257 check started passing {"namespace": "health", "name": "C", "tags": ["11111111111111111111111111111111LpoYY"]}
Nov 02 17:45:41 104 bash[566175]: [11-02|17:45:41.102] TRACE <P Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "2MMqBzd7DCJJTEeAuv9VZAHcKXHHGssCefUPRyt6XtqaVLeJJj", "blkHeight": 9616799}
Nov 02 17:45:41 104 bash[566175]: [11-02|17:45:41.102] TRACE <P Chain> executor/acceptor.go:219 accepted block {"blockType": "banff proposal", "blkID": "BKJfX8kwowRFVoJpbraVxLfHpegeBEwZTVQRPkWvJnaRohJSZ", "height": 9616799, "parentID": "dF2i7fZqCa9AUguvcznB8pvvrP1z22Kyrns79Yq2Sh9oWAnmb", "utxoChecksum": "11111111111111111111111111111111LpoYY"}
Nov 02 17:45:41 104 bash[566175]: [11-02|17:45:41.102] TRACE <P Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "nk8GSquJ5Rsh3R5j4ZZ56FnZBBZTeHCUsU7mwGBamNq3uZQsy", "blkHeight": 9616800}
Nov 02 17:45:41 104 bash[566175]: [11-02|17:45:41.103] TRACE <P Chain> executor/acceptor.go:187 accepted block {"blockType": "apricot commit", "blkID": "2brCXSNQgX548kwgrZXRhJfGvQnaqiQVZryeus5JCxmmessTuy", "height": 9616800, "parentID": "BKJfX8kwowRFVoJpbraVxLfHpegeBEwZTVQRPkWvJnaRohJSZ", "utxoChecksum": "11111111111111111111111111111111LpoYY"}
Nov 02 17:45:46 104 bash[566175]: [11-02|17:45:46.716] INFO <C Chain> syncer/state_syncer.go:353 accepted state summary {"summaryID": "9QAv1ffWfCGUiSLwfwYtVS4xU8WQm1Zh27AXKGUss87KS7zqy", "syncMode": "Skipped", "numTotalSummaries": 1}
Nov 02 17:45:46 104 bash[566175]: [11-02|17:45:46.716] INFO <C Chain> bootstrap/bootstrapper.go:115 starting bootstrapper
Nov 02 17:45:55 104 bash[566175]: [11-02|17:45:55.153] TRACE <P Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "2hZNtRx48XGcV6pQmZS4aNTjzwQwYQhzMamYayA7yPnhhJDPAg", "blkHeight": 9616801}
Nov 02 17:45:55 104 bash[566175]: [11-02|17:45:55.153] TRACE <P Chain> executor/acceptor.go:219 accepted block {"blockType": "banff proposal", "blkID": "2W8mtnJsKD4AoW7dcra7xM7uXj5dkNe7hbnUtsmo5Ui5tiu6iS", "height": 9616801, "parentID": "2brCXSNQgX548kwgrZXRhJfGvQnaqiQVZryeus5JCxmmessTuy", "utxoChecksum": "11111111111111111111111111111111LpoYY"}
Nov 02 17:45:55 104 bash[566175]: [11-02|17:45:55.153] TRACE <P Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "2vKNhqEUeq9KNYie66XEfkig8Xn3mUDXbP8Lyez64oZvvPhogr", "blkHeight": 9616802}
Nov 02 17:45:55 104 bash[566175]: [11-02|17:45:55.154] TRACE <P Chain> executor/acceptor.go:187 accepted block {"blockType": "apricot commit", "blkID": "9ewP4gTuVwRohTLNkhQ365kGNiZ5o9CKtWDjFSgCrbvp8X5Sg", "height": 9616802, "parentID": "2W8mtnJsKD4AoW7dcra7xM7uXj5dkNe7hbnUtsmo5Ui5tiu6iS", "utxoChecksum": "11111111111111111111111111111111LpoYY"}
Nov 02 17:45:55 104 bash[566175]: [11-02|17:45:55.154] TRACE <P Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "25NT4VtxvCNUrDXr3GeiuRvntg7U4H879w9Kb6uaffopQRFYGQ", "blkHeight": 9616803}
Nov 02 17:45:55 104 bash[566175]: [11-02|17:45:55.154] TRACE <P Chain> executor/acceptor.go:219 accepted block {"blockType": "banff proposal", "blkID": "2Q2ih2RpGSTutQ5XjtqM18czNczBN88DGgiDLtkeenZGBrXN2y", "height": 9616803, "parentID": "9ewP4gTuVwRohTLNkhQ365kGNiZ5o9CKtWDjFSgCrbvp8X5Sg", "utxoChecksum": "11111111111111111111111111111111LpoYY"}
Nov 02 17:45:55 104 bash[566175]: [11-02|17:45:55.155] TRACE <P Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "2e9Ls2FkM7CUMHtNwtSYVcyaPdzHGJHZTXsooxeRKFhqQnunUx", "blkHeight": 9616804}
Nov 02 17:45:55 104 bash[566175]: [11-02|17:45:55.155] TRACE <P Chain> executor/acceptor.go:187 accepted block {"blockType": "apricot commit", "blkID": "rrQF29ZVHnyQAQKYq5ZTeqpW4qDkJnjhwssn2R2BUufshLnBk", "height": 9616804, "parentID": "2Q2ih2RpGSTutQ5XjtqM18czNczBN88DGgiDLtkeenZGBrXN2y", "utxoChecksum": "11111111111111111111111111111111LpoYY"}
Nov 02 17:45:55 104 bash[566175]: [11-02|17:45:55.155] TRACE <P Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "2ZngAvczprJZybSdjaRuBRV5wHAQRw2F4qDYPzDXifq9rEaE66", "blkHeight": 9616805}
Nov 02 17:45:55 104 bash[566175]: [11-02|17:45:55.156] TRACE <P Chain> executor/acceptor.go:266 accepted block {"blockType": "banff standard", "blkID": "UM4ygNLGxLW3pQQD9iUjEnA8t4B39CieKmtGcf9cFjh8ZTDri", "height": 9616805, "parentID": "rrQF29ZVHnyQAQKYq5ZTeqpW4qDkJnjhwssn2R2BUufshLnBk", "utxoChecksum": "11111111111111111111111111111111LpoYY"}
Nov 02 17:45:55 104 bash[566175]: [11-02|17:45:55.156] TRACE <P Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "25BFTa5ntq6z3JA3yVnBsTp7icFMBR7kUNimvrasepWiWToRNj", "blkHeight": 9616806}
Nov 02 17:45:55 104 bash[566175]: [11-02|17:45:55.157] TRACE <P Chain> executor/acceptor.go:266 accepted block {"blockType": "banff standard", "blkID": "Vpw8MCQrNk8ofkSYzKPHr9SkSVUwpxQhHpr715ejoMHKDwWPC", "height": 9616806, "parentID": "UM4ygNLGxLW3pQQD9iUjEnA8t4B39CieKmtGcf9cFjh8ZTDri", "utxoChecksum": "11111111111111111111111111111111LpoYY"}
Nov 02 17:45:55 104 bash[566175]: [11-02|17:45:55.157] TRACE <P Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "PXrM7Ne3W346J6nKHBUxL3c9ZGAtBr18dBN6gsPVMwhXvSH36", "blkHeight": 9616807}
Nov 02 17:45:55 104 bash[566175]: [11-02|17:45:55.157] TRACE <P Chain> executor/acceptor.go:266 accepted block {"blockType": "banff standard", "blkID": "2C7vS8iKHSS5YNYSJ9GSPMxHjaANjZ9Xd2ZK1DGpfjnMDDNCUv", "height": 9616807, "parentID": "Vpw8MCQrNk8ofkSYzKPHr9SkSVUwpxQhHpr715ejoMHKDwWPC", "utxoChecksum": "11111111111111111111111111111111LpoYY"}
Nov 02 17:45:59 104 bash[566175]: [11-02|17:45:59.358] INFO <X Chain> common/bootstrapper.go:268 bootstrapping started syncing {"numVerticesInFrontier": 1}
Nov 02 17:45:59 104 bash[566175]: [11-02|17:45:59.358] INFO <X Chain> bootstrap/bootstrapper.go:564 executing blocks {"numPendingJobs": 0}
Nov 02 17:45:59 104 bash[566175]: [11-02|17:45:59.358] INFO <X Chain> queue/jobs.go:224 executed operations {"numExecuted": 0}
Nov 02 17:45:59 104 bash[566175]: [11-02|17:45:59.358] INFO <X Chain> bootstrap/bootstrapper.go:609 waiting for the remaining chains in this subnet to finish syncing
Nov 02 17:46:02 104 bash[566175]: [11-02|17:46:02.647] INFO <C Chain> common/bootstrapper.go:268 bootstrapping started syncing {"numVerticesInFrontier": 1}
Nov 02 17:46:07 104 bash[566175]: [11-02|17:46:07.877] INFO <C Chain> bootstrap/bootstrapper.go:564 executing blocks {"numPendingJobs": 46}
Nov 02 17:46:07 104 bash[566175]: [11-02|17:46:07.910] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "Nd7ZsJWndUyKJNP8Q4AVQkZSAd2ZH6zWzqJSA2myBdDawC29K", "blkHeight": 37235674}
Nov 02 17:46:07 104 bash[566175]: [11-02|17:46:07.937] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "2nXb6GLnAigrYeuXevBrEwd6ruHkL8ViJKdQrG2ptrRMzv4jG8", "blkHeight": 37235675}
Nov 02 17:46:07 104 bash[566175]: [11-02|17:46:07.989] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "2DwgiEWUXpyovKcqgDTXLcKmUQzP9a4HRGTBz45AccERgxcVzW", "blkHeight": 37235676}
Nov 02 17:46:08 104 bash[566175]: [11-02|17:46:08.027] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "26HaUX6xBy1KShA7eLUQtZL8RVpAMU3TaGJLy9HoduLv6Kfdj1", "blkHeight": 37235677}
Nov 02 17:46:08 104 bash[566175]: [11-02|17:46:08.041] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "2wXNZ1kB7Vbnjwq9mt84t8j1Cn29zZTiZkTfhaMmgmk7EN5VfU", "blkHeight": 37235678}
Nov 02 17:46:08 104 bash[566175]: [11-02|17:46:08.044] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "2bL2hVfnSayZGqZzCP2uRRS9PY5KBTDjR56wBYhPPayiC9dQxP", "blkHeight": 37235679}
Nov 02 17:46:08 104 bash[566175]: [11-02|17:46:08.073] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "2G221RoKd6FsiQbHPYivc4x9RXxfuECbTev3wdbFeapyAsVYvk", "blkHeight": 37235680}
Nov 02 17:46:08 104 bash[566175]: [11-02|17:46:08.074] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "2t7MDNMmGJbDqxtarP8FmViZX47ngyBdchzSUEHercfjKas3DB", "blkHeight": 37235681}
Nov 02 17:46:08 104 bash[566175]: [11-02|17:46:08.097] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "2JdDjWRyExnRcjnE9Yruboz39w442C9SyWjh32FpzziXhBdX9b", "blkHeight": 37235682}
Nov 02 17:46:08 104 bash[566175]: [11-02|17:46:08.109] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "2bsMd5t7SE32iTLAyMLmDErFKE8BvHFfA5dCgKSPJ5pc8XQYZE", "blkHeight": 37235683}
Nov 02 17:46:08 104 bash[566175]: [11-02|17:46:08.128] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "2ukGswridjyfuXR2RNbdtYKxtoBhj8ubBJn3kyrfDNn53QMdNa", "blkHeight": 37235684}
Nov 02 17:46:08 104 bash[566175]: [11-02|17:46:08.153] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "2JVYQab2jrdGHoyBRjHQuchs5Z17njGYmTQ8vogpuePhXF9e93", "blkHeight": 37235685}
Nov 02 17:46:08 104 bash[566175]: [11-02|17:46:08.161] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "2LarWwDq42E5kA5azsjEqYbMCQLohYgGRA4HepEueqMY6Z3fQp", "blkHeight": 37235686}
Nov 02 17:46:08 104 bash[566175]: [11-02|17:46:08.175] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "8kqd7vvNvVzoToNLZh7iLekzW59GqMDmxUQS21ci67dAGzpZk", "blkHeight": 37235687}
Nov 02 17:46:08 104 bash[566175]: [11-02|17:46:08.185] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "2doDzdLfjznL8BTUMuvMUaetzsassUzsbtWR4VPMSbkFrqYzVJ", "blkHeight": 37235688}
Nov 02 17:46:08 104 bash[566175]: [11-02|17:46:08.189] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "2MUqYQeUiQUFGhK739EWuGfQapih8bdmM9UinXmocYfT19y6UD", "blkHeight": 37235689}
Nov 02 17:46:08 104 bash[566175]: [11-02|17:46:08.196] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "26p8YbCJAbt9zD1xs7AENpWaLtgmqsLc4vn4fUGUoT5kfFf4gE", "blkHeight": 37235690}
Nov 02 17:46:08 104 bash[566175]: [11-02|17:46:08.214] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "2FcYMXTeofcgorKQwyy7XiMnsFjJWJJDat3K7KCzpC2M3XVyYf", "blkHeight": 37235691}
Nov 02 17:46:08 104 bash[566175]: [11-02|17:46:08.218] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "hsrAr7FpMDyRskjNyyFK34KEhpCyWtGtmAhV7d7pc3gni9kDU", "blkHeight": 37235692}
Nov 02 17:46:08 104 bash[566175]: [11-02|17:46:08.228] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "DrUQofQRYYjtdYaNsmAfWCAWMdZU9pFuupsz4h26iGHCoQ1sE", "blkHeight": 37235693}
Nov 02 17:46:08 104 bash[566175]: [11-02|17:46:08.248] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "z6BT79iDMBWWd7LSjNcGeC49PWcznqMQr8ftCQkoAMZx5Nxio", "blkHeight": 37235694}
Nov 02 17:46:08 104 bash[566175]: [11-02|17:46:08.253] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "28x3XBSo195jQ3vwWKUbcPmZvTFKLqWoPTJ5EZgFWpAM8STLg4", "blkHeight": 37235695}
Nov 02 17:46:08 104 bash[566175]: [11-02|17:46:08.265] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "QRBB4V3252q5wwoupNKaeFBJco7rL6HnjZZ3rynZDdHh2D7z2", "blkHeight": 37235696}
Nov 02 17:46:08 104 bash[566175]: [11-02|17:46:08.284] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "hLXZVA9qAv2JnZgyNxc1Du3pa1D4dnYFHiXnkmZDB4Vhecvrp", "blkHeight": 37235697}
Nov 02 17:46:08 104 bash[566175]: [11-02|17:46:08.302] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "2KgvBNVm1o2JJmyKVHHrRUXXTiYY3Nh9PYYHxkG9ScRAi3uhkC", "blkHeight": 37235698}
Nov 02 17:46:08 104 bash[566175]: [11-02|17:46:08.312] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "x8MkBNrW34BdgJbs9Sd72MDBCMrouS6HzJebyJpL2eanFiDVT", "blkHeight": 37235699}
Nov 02 17:46:08 104 bash[566175]: [11-02|17:46:08.396] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "2M8mdLWgWk1CEkyRiBpA4DRGmtWB2cYPPPqYwZmw95hS9cA5kQ", "blkHeight": 37235700}
Nov 02 17:46:08 104 bash[566175]: [11-02|17:46:08.416] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "2niWf1CGXojDCXThFhhrBKNLHQtzw3jyFdpsz2ccGfhvRdZrax", "blkHeight": 37235701}
Nov 02 17:46:08 104 bash[566175]: [11-02|17:46:08.433] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "nu4FvP4UPmcn2ZJqWUHba84HDjTEhhYZ18DEzV8caeWUqWQ41", "blkHeight": 37235702}
Nov 02 17:46:08 104 bash[566175]: [11-02|17:46:08.461] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "PUpC934ZXaQFMgh5WtjNmpjmmkvKQSTf9f2F4LtM8CvS5xVcn", "blkHeight": 37235703}
Nov 02 17:46:08 104 bash[566175]: [11-02|17:46:08.487] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "28XaX7JDnrz2qZSNHt69AM9k9oUPzLaDDuJtZ24kpzr8c51mxY", "blkHeight": 37235704}
Nov 02 17:46:08 104 bash[566175]: [11-02|17:46:08.496] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "2hxp5NmeHi9rmS82n7QjPpdyF3oGTzAvagUyorFb2uvycDsccz", "blkHeight": 37235705}
Nov 02 17:46:08 104 bash[566175]: [11-02|17:46:08.502] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "vyHLf3ghqhAULVxM3kJNgptp6p9UZpLdx8dUhgxsxe7uu9JE5", "blkHeight": 37235706}
Nov 02 17:46:08 104 bash[566175]: [11-02|17:46:08.511] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "2kgi9dqo3ahNovutNABCDWWptnZvNiuSYEXUfTLXBVrv3sh4j6", "blkHeight": 37235707}
Nov 02 17:46:08 104 bash[566175]: [11-02|17:46:08.525] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "aHHVgkKeuGFWfzRqUGb8XFynP7QCFsM2FXCHbUm8eGA4Qh1CA", "blkHeight": 37235708}
Nov 02 17:46:08 104 bash[566175]: [11-02|17:46:08.528] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "2aUmrhimapdHPoGfUoVqqQkmQTYhu1dys9BTTFFhXi2cDXMRWU", "blkHeight": 37235709}
Nov 02 17:46:08 104 bash[566175]: [11-02|17:46:08.537] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "rMn6C4aKfovnkb3ETTaL9AQfrFobJiPrp7NeJgvi6QfdhiDBt", "blkHeight": 37235710}
Nov 02 17:46:08 104 bash[566175]: [11-02|17:46:08.548] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "2noLZM6G5fpmBNuBGHcx31JmSQHLQzCskxczvVn8umrSQPwRRK", "blkHeight": 37235711}
Nov 02 17:46:08 104 bash[566175]: [11-02|17:46:08.562] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "v6SsrcDjHRyzajSNpt4KAUfEqEeXrgsqKPWYPozKtBJZJbnnk", "blkHeight": 37235712}
Nov 02 17:46:08 104 bash[566175]: [11-02|17:46:08.568] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "UWebh5SYoddabRjx2MXHct4dND2cP2gRxbJS9bdiu7a65cS8Y", "blkHeight": 37235713}
Nov 02 17:46:08 104 bash[566175]: [11-02|17:46:08.580] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "2qE82AKU3dsm6NzVMWJNtXBXCZ3zPLp5PuScUPx41egJVdPoCG", "blkHeight": 37235714}
Nov 02 17:46:08 104 bash[566175]: [11-02|17:46:08.601] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "26sHfzG8gsy93mR9uvJk8y6rrTQB5Sthz7QoknzsYT51zQTVBZ", "blkHeight": 37235715}
Nov 02 17:46:08 104 bash[566175]: [11-02|17:46:08.641] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "Xj5m5J3psBgBA4FXVRturzp4Aq32u9EDf2NA5nKaaMMZsgrtt", "blkHeight": 37235716}
Nov 02 17:46:08 104 bash[566175]: [11-02|17:46:08.699] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "aSPv5LnEDs2JncexVDn9FHvDqUhtMtZTjwxh9r1HtHYK1J6mX", "blkHeight": 37235717}
Nov 02 17:46:08 104 bash[566175]: [11-02|17:46:08.717] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "n1mXFtFFbPYFUY4XQvkcWEG7JeQB51P5Z7cXccRqFNC9EhdDP", "blkHeight": 37235718}
Nov 02 17:46:08 104 bash[566175]: [11-02|17:46:08.732] TRACE <C Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "RUaqsG5ZnUmMHm4qjKmRh9v5A3tggWgvGi5P3bxXPVjcBGUSs", "blkHeight": 37235719}
Nov 02 17:46:08 104 bash[566175]: [11-02|17:46:08.732] INFO <C Chain> queue/jobs.go:224 executed operations {"numExecuted": 46}
Nov 02 17:46:09 104 bash[566175]: [11-02|17:46:09.508] TRACE <P Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "2i43p6MYGf2XUw8wRmETV4ixx392GbaGhrZsvqRSQTVdEyfd1z", "blkHeight": 9616808}
Nov 02 17:46:09 104 bash[566175]: [11-02|17:46:09.509] TRACE <P Chain> executor/acceptor.go:266 accepted block {"blockType": "banff standard", "blkID": "hGt6Bo8p2XtS3NFdfeSPasbuxViURexfZrGvm2RU2tJcLmskK", "height": 9616808, "parentID": "2C7vS8iKHSS5YNYSJ9GSPMxHjaANjZ9Xd2ZK1DGpfjnMDDNCUv", "utxoChecksum": "11111111111111111111111111111111LpoYY"}
Nov 02 17:46:09 104 bash[566175]: [11-02|17:46:09.509] TRACE <P Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "pmeXZnKsWkFiKdBHQppGNAerwqqRPbmf7gXVHeVTCxSVANWJ3", "blkHeight": 9616809}
Nov 02 17:46:09 104 bash[566175]: [11-02|17:46:09.510] TRACE <P Chain> executor/acceptor.go:266 accepted block {"blockType": "banff standard", "blkID": "U9ynBzXJUQdMgiYUJyxCPnLN9jDvyfU6jDbVqLJfh9cLwTh4w", "height": 9616809, "parentID": "hGt6Bo8p2XtS3NFdfeSPasbuxViURexfZrGvm2RU2tJcLmskK", "utxoChecksum": "11111111111111111111111111111111LpoYY"}
Nov 02 17:46:09 104 bash[566175]: [11-02|17:46:09.510] TRACE <P Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "2tKVwzrShh4znZrAZ31NWihQhGyvq13f9tyBkbe4DJqWKzEnL6", "blkHeight": 9616810}
Nov 02 17:46:09 104 bash[566175]: [11-02|17:46:09.510] TRACE <P Chain> executor/acceptor.go:266 accepted block {"blockType": "banff standard", "blkID": "2dF2YDc7Du98fakfeduPFX6RVxnDbEvaiRcfgZQVZA2zt5VpyR", "height": 9616810, "parentID": "U9ynBzXJUQdMgiYUJyxCPnLN9jDvyfU6jDbVqLJfh9cLwTh4w", "utxoChecksum": "11111111111111111111111111111111LpoYY"}
Nov 02 17:46:09 104 bash[566175]: [11-02|17:46:09.510] TRACE <P Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "2r93UrvbLxC7a2bpsFyyfBPPtk1cZxCzHBg416K9dezJndQp6U", "blkHeight": 9616811}
Nov 02 17:46:09 104 bash[566175]: [11-02|17:46:09.510] TRACE <P Chain> executor/acceptor.go:219 accepted block {"blockType": "banff proposal", "blkID": "2vGPW6UXwLkb9pnTULFtpQvG8fhZjCqh9VRNqrmfmnmhqG1QXZ", "height": 9616811, "parentID": "2dF2YDc7Du98fakfeduPFX6RVxnDbEvaiRcfgZQVZA2zt5VpyR", "utxoChecksum": "11111111111111111111111111111111LpoYY"}
Nov 02 17:46:09 104 bash[566175]: [11-02|17:46:09.511] TRACE <P Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "aQYj5u3sC776a8NsMZbpzoLS99iSdnwenfCN84HUzcQFDVucM", "blkHeight": 9616812}
Nov 02 17:46:09 104 bash[566175]: [11-02|17:46:09.512] TRACE <P Chain> executor/acceptor.go:187 accepted block {"blockType": "apricot commit", "blkID": "2LNgHyP2Ba1MPXSLNfvw9N3ydLLXKcLJgDvQZRvRuTgKbf7EkL", "height": 9616812, "parentID": "2vGPW6UXwLkb9pnTULFtpQvG8fhZjCqh9VRNqrmfmnmhqG1QXZ", "utxoChecksum": "11111111111111111111111111111111LpoYY"}
Nov 02 17:46:09 104 bash[566175]: [11-02|17:46:09.512] TRACE <P Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "PKt6fopeS8fqct4GheX22xECccsyPPpHxej8KepGenxjFxLA3", "blkHeight": 9616813}
Nov 02 17:46:09 104 bash[566175]: [11-02|17:46:09.512] TRACE <P Chain> executor/acceptor.go:266 accepted block {"blockType": "banff standard", "blkID": "2UFcHKWB9GjWXxwMu2ciAP9rETLnGckxRTwKBSdACsAJcnTUaJ", "height": 9616813, "parentID": "2LNgHyP2Ba1MPXSLNfvw9N3ydLLXKcLJgDvQZRvRuTgKbf7EkL", "utxoChecksum": "11111111111111111111111111111111LpoYY"}
^C
[one@104 ~]$

Metrics If applicable, please include any metrics gathered from your node to assist us in diagnosing the problem.

Operating System

[root@104 ~]# uname -a
Linux 104 5.15.0-104.119.4.2.el9uek.x86_64 #2 SMP Fri Aug 18 20:03:32 PDT 2023 x86_64 x86_64 x86_64 GNU/Linux
[root@104 ~]# cat /etc/os-release 
NAME="Oracle Linux Server"
VERSION="9.2"
ID="ol"
ID_LIKE="fedora"
VARIANT="Server"
VARIANT_ID="server"
VERSION_ID="9.2"
PLATFORM_ID="platform:el9"
PRETTY_NAME="Oracle Linux Server 9.2"
ANSI_COLOR="0;31"
CPE_NAME="cpe:/o:oracle:linux:9:2:server"
HOME_URL="https://linux.oracle.com/"
BUG_REPORT_URL="https://github.com/oracle/oracle-linux"

ORACLE_BUGZILLA_PRODUCT="Oracle Linux 9"
ORACLE_BUGZILLA_PRODUCT_VERSION=9.2
ORACLE_SUPPORT_PRODUCT="Oracle Linux"
ORACLE_SUPPORT_PRODUCT_VERSION=9.2
[root@104 ~]#

CPU: r9 5950x RAM: 128G Additional context Add any other context about the problem here. Please help me troubleshoot the cause, I really need the archived block data for development, thank you very much 🙏! To best protect the Avalanche community security bugs should be reported in accordance to our Security Policy

StephenButtolph commented 11 months ago 
"state-sync-enabled": true,

in the C-chain config means that the node will sync to the current state of the C-chain. It will not sync the historical state of the C-chain unless

"state-sync-enabled": false,

is provided.

See State Sync and state-sync-enabled in the docs.

presIey commented 11 months ago

Thank you,I'll try it.

presIey commented 11 months ago 
 16:18:28 104 bash[3492534]: [11-06|16:18:28.505] TRACE <P Chain> executor/acceptor.go:266 accepted block {"blockType": "banff standard", "blkID": "27KQYKFqNWJCfSf7FUXAzh6RSUwuUFeaGPDZcXSoyqyh8rMG76", "height": 9691189, "parentID": "jv1CVGeg5qXMDjG1Wqv3JBCZViccxHj7JAeydCbSadVUbPqGt", "utxoChecksum": "11111111111111111111111111111111LpoYY"}
Nov 06 16:18:28 104 bash[3492534]: [11-06|16:18:28.506] TRACE <P Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "FQogfeLfYrRo2obcAehyc5KmcLp73dMeBiQByVqQ5b198Mi2V", "blkHeight": 9691190}
Nov 06 16:18:28 104 bash[3492534]: [11-06|16:18:28.506] TRACE <P Chain> executor/acceptor.go:266 accepted block {"blockType": "banff standard", "blkID": "kHvaZXeCLhPvQw45yoAAxPHTET7TaQAQRsqvM9K6Hx3LNuucZ", "height": 9691190, "parentID": "27KQYKFqNWJCfSf7FUXAzh6RSUwuUFeaGPDZcXSoyqyh8rMG76", "utxoChecksum": "11111111111111111111111111111111LpoYY"}
Nov 06 16:18:28 104 bash[3492534]: [11-06|16:18:28.507] TRACE <P Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "2E9a4rpZr5TAHcbGqD52VzSnpNpHsg14RfvmsntRrSC3HqZGhM", "blkHeight": 9691191}
Nov 06 16:18:28 104 bash[3492534]: [11-06|16:18:28.508] TRACE <P Chain> executor/acceptor.go:266 accepted block {"blockType": "banff standard", "blkID": "2ecDah7htg77Yupio4h84nsn9f3BtdkDDbb2wm4BY47ghH4c51", "height": 9691191, "parentID": "kHvaZXeCLhPvQw45yoAAxPHTET7TaQAQRsqvM9K6Hx3LNuucZ", "utxoChecksum": "11111111111111111111111111111111LpoYY"}
Nov 06 16:18:28 104 bash[3492534]: [11-06|16:18:28.508] TRACE <P Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "vuLMVXc3eqMagtc2Gf1VtAPYrsZvwcJjQu6d3JSobDesp633i", "blkHeight": 9691192}
Nov 06 16:18:28 104 bash[3492534]: [11-06|16:18:28.509] TRACE <P Chain> executor/acceptor.go:266 accepted block {"blockType": "banff standard", "blkID": "24ru9YnEYgKBpEPoVWg6dMdhh5MfmvvEh9shjgiWZAVUhbLYkJ", "height": 9691192, "parentID": "2ecDah7htg77Yupio4h84nsn9f3BtdkDDbb2wm4BY47ghH4c51", "utxoChecksum": "11111111111111111111111111111111LpoYY"}
Nov 06 16:18:28 104 bash[3492534]: [11-06|16:18:28.510] TRACE <P Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "29x42RUTL9WnJiYbify5tPqCCiXdH6vnPBHL8M48r5LeHyQrit", "blkHeight": 9691193}
Nov 06 16:18:28 104 bash[3492534]: [11-06|16:18:28.510] TRACE <P Chain> executor/acceptor.go:266 accepted block {"blockType": "banff standard", "blkID": "25fpxSM1X6yD8Kt3FEfZRfFQgEDbammkrHQkERSAZDLh5o5BkS", "height": 9691193, "parentID": "24ru9YnEYgKBpEPoVWg6dMdhh5MfmvvEh9shjgiWZAVUhbLYkJ", "utxoChecksum": "11111111111111111111111111111111LpoYY"}
Nov 06 16:18:33 104 bash[3492534]: [11-06|16:18:33.719] TRACE <X Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "2GgPduSVBVCGHPmQijpyK6udt2iVsb1GDuBoAeqPzrN9JcvAxw", "blkHeight": 165517}
Nov 06 16:18:33 104 bash[3492534]: [11-06|16:18:33.719] TRACE <X Chain> executor/block.go:253 accepted block {"blkID": "2ta8cEi4QmBd8JSiKBjgdWeC15njZ6FTxsSBxFKhQCPsU328qC", "height": 165517, "parentID": "LWu3wVnAwZGYiiyGCN4zE6Yix9Eb3NuVWi7Z7C2ukBFoBh6Wq", "txChecksum": "11111111111111111111111111111111LpoYY", "utxoChecksum": "11111111111111111111111111111111LpoYY"}
Nov 06 16:19:19 104 bash[3492534]: [11-06|16:19:19.585] INFO <C Chain> bootstrap/bootstrapper.go:505 fetching blocks {"numFetchedBlocks": 2365000, "numTotalBlocks": 37316913, "eta": "715h27m58s"}
Nov 06 16:20:48 104 bash[3492534]: [11-06|16:20:48.230] TRACE <P Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "nUaNwR4H2YFutnNkCxFPHaVvhLWnfMoJbPXvfKB5U6TmzKdqv", "blkHeight": 9691194}
Nov 06 16:20:48 104 bash[3492534]: [11-06|16:20:48.230] TRACE <P Chain> executor/acceptor.go:219 accepted block {"blockType": "banff proposal", "blkID": "2NXf97JmRXgbPgYpxnABLAZVNy8YkLYAkA1dyEATWs9nz1sojW", "height": 9691194, "parentID": "25fpxSM1X6yD8Kt3FEfZRfFQgEDbammkrHQkERSAZDLh5o5BkS", "utxoChecksum": "11111111111111111111111111111111LpoYY"}
Nov 06 16:20:48 104 bash[3492534]: [11-06|16:20:48.230] TRACE <P Chain> bootstrap/block_job.go:99 accepting block in bootstrapping {"blkID": "21UR15J1VEKpMavqHXhh4kMBRY4Fbv7SyWNJ9VMF8Jw8FghdFi", "blkHeight": 9691195}
Nov 06 16:20:48 104 bash[3492534]: [11-06|16:20:48.232] TRACE <P Chain> executor/acceptor.go:187 accepted block {"blockType": "apricot commit", "blkID": "2Vxvw6KnDt6EB21NMV3cWxHcFH7icKJfzNXyR1L5JdmU87vnuM", "height": 9691195, "parentID": "2NXf97JmRXgbPgYpxnABLAZVNy8YkLYAkA1dyEATWs9nz1sojW", "utxoChecksum": "11111111111111111111111111111111LpoYY"}
...
"numTotalBlocks": 37316913, "eta": "715h27m58s"}
...

But the synchronization is too slow. My server is r9 5950x 128g RAM. Is there any way to speed it up? I do need to archive the node.

github-actions[bot] commented 9 months ago

This issue has become stale because it has been open 60 days with no activity. Adding the lifecycle/frozen label will cause this issue to ignore lifecycle events.