En 서버에서 동기화 진행이 안되는 문제

akjkcham · 3월 24, 2022, 11:44오전

안녕하세요.

서비스 체인을 테스트하고 있습니다.

진행 과정중 EN서버를 baobab에 연결후 단한번도 블록동기화가 진행되지 않고 있습니다.

지속적으로 블록을 확인해보면 계속 0입니다.
ken attach --datadir ~/data
klay.blockNumber
0

Baobab 스냅샷 아카이브를 이용해서 FastSync를 진행하면 블록넘버가 0보다 큰수가 나오지만 단한번도 EN이 동기화를 진행하지 않습니다.
(메뉴얼에 나오는 동기화 로그가 확인이 안됩니다)

메뉴얼 대로 설정하여 진행하였는데 여기서 막히고 있습니다.

테스트 단계라서 맥북+무선랜을 사용한것이 문제가 될까요?

도움좀 부탁드립니다 (_ _)

//--------------------
// 구성환경
//--------------------
머신 : mac-m1-pro | 16기가 | 1테라 | 10코어
회선 : 무선
버전 : ken-baobab-v1.7.3-0-darwin-10.10-amd64.tar.gz

//--------------------
// kend.conf
//--------------------
NETWORK=“baobab”
NETWORK_ID=
SC_MAIN_BRIDGE=1
DATA_DIR=~/data

//--------------------
// kend.out 로그기록
//--------------------
INFO[03/24,19:44:06 +09] [31] Enabling metrics INFO[03/24,19:44:06 +09] [31] Enabling Prometheus INFO[03/24,19:44:06 +09] [18] Setting connection type INFO[03/24,19:44:06 +09] [18] Baobab bootnodes INFO[03/24,19:44:06 +09] [18] Bootnode - Add Seed INFO[03/24,19:44:06 +09] [18] Setting MaxPhysicalConnections INFO[03/24,19:44:06 +09] [18] Baobab network ID is set INFO[03/24,19:44:06 +09] [18] Raised fd limit INFO[03/24,19:44:06 +09] [18] Baobab network ID is set INFO[03/24,19:44:06 +09] [18] Archiving mode of this node INFO[03/24,19:44:06 +09] [40] Starting peer-to-peer node INFO[03/24,19:44:06 +09] [46] Non-single database INFO[03/24,19:44:06 +09] [46] LevelDB configurations INFO[03/24,19:44:06 +09] [46] LevelDB configurations INFO[03/24,19:44:06 +09] [46] LevelDB configurations INFO[03/24,19:44:06 +09] [46] LevelDB configurations INFO[03/24,19:44:06 +09] [46] LevelDB configurations INFO[03/24,19:44:07 +09] [46] LevelDB configurations INFO[03/24,19:44:07 +09] [46] LevelDB configurations INFO[03/24,19:44:07 +09] [46] LevelDB configurations INFO[03/24,19:44:07 +09] [46] Created a sharded database INFO[03/24,19:44:07 +09] [46] LevelDB configurations INFO[03/24,19:44:07 +09] [46] LevelDB configurations INFO[03/24,19:44:07 +09] [30] No governance INFO[03/24,19:44:07 +09] [41] Initialised chain configuration INFO[03/24,19:44:07 +09] [41] Initialising Klaytn protocol WARN[03/24,19:44:07 +09] [5] Upgrade database version INFO[03/24,19:44:07 +09] [5] Using DeriveShaConcat!< INFO[03/24,19:44:07 +09] [47] Initializing INFO[03/24,19:44:07 +09] [47] Initialized local INFO[03/24,19:44:07 +09] [5] Loaded most recent local header INFO[03/24,19:44:07 +09] [5] Loaded most recent local full block INFO[03/24,19:44:07 +09] [5] Loaded most recent local fast block INFO[03/24,19:44:07 +09] [5] prefetchTxWorkers are started INFO[03/24,19:44:07 +09] [5] Regenerated local INFO[03/24,19:44:07 +09] [46] Non-single database INFO[03/24,19:44:07 +09] [46] LevelDB configurations INFO[03/24,19:44:07 +09] [46] LevelDB configurations INFO[03/24,19:44:07 +09] [46] LevelDB configurations INFO[03/24,19:44:07 +09] [46] LevelDB configurations INFO[03/24,19:44:07 +09] [46] LevelDB configurations INFO[03/24,19:44:07 +09] [46] LevelDB configurations INFO[03/24,19:44:08 +09] [46] LevelDB configurations INFO[03/24,19:44:08 +09] [45] Initialising ERROR[03/24,19:44:08 +09] [45] p2p rpc registered ERROR[03/24,19:44:08 +09] [45] p2p rpc registered ERROR[03/24,19:44:08 +09] [45] p2p rpc registered ERROR[03/24,19:44:08 +09] [45] p2p rpc registered ERROR[03/24,19:44:08 +09] [45] p2p rpc registered ERROR[03/24,19:44:08 +09] [45] p2p rpc registered ERROR[03/24,19:44:08 +09] [45] p2p rpc registered ERROR[03/24,19:44:08 +09] [45] p2p rpc registered ERROR[03/24,19:44:08 +09] [45] p2p rpc registered INFO[03/24,19:44:08 +09] [40] Starting P2P INFO[03/24,19:44:10 +09] [35] Mapped network port INFO[03/24,19:44:10 +09] [34] UDP listener up INFO[03/24,19:44:10 +09] [40] RLPx listener up INFO[03/24,19:44:10 +09] [40] RLPx listener up INFO[03/24,19:44:10 +09] [40] Started P2P server INFO[03/24,19:44:10 +09] [45] Starting P2P INFO[03/24,19:44:10 +09] [44] Start listening INFO[03/24,19:44:10 +09] [45] Started P2P server INFO[03/24,19:44:10 +09] [45] RLPx listener up INFO[03/24,19:44:10 +09] [40] IPC endpoint opened INFO[03/24,19:44:10 +09] [40] FastHTTP endpoint opened INFO[03/24,19:44:10 +09] [40] FastWebSocket endpoint opened INFO[03/24,19:44:10 +09] [35] Mapped network port INFO[03/24,19:44:10 +09] [35] Mapped network port collection
Exporter
nodetype=en conntype=1
are set
Node=“kni://779d766628247ebda5f3e108e9303bd8efdb8eba9fd8d6c529e2614aec7207ebf6614fe7e61d0d99b75e8b23dd3a679b112fd0de7e4e71a7008f0718710da48f@52.79.223.199:32323?ntype=bn”
MaxPhysicalConnections=10
networkid=1001
to process’s maximum value fd=10240
networkid=1001
isArchiveMode=false
instance=Klaytn/v1.7.3+acae89350c/darwin-amd64/go1.15.7
is used for persistent storage DBType=LevelDB
path=/Users/pooh/data/klay/chaindata/misc levelDBCacheSize=16 openFilesLimit=102 useBufferPool=true usePerfCheck=true compressionType=none compactionTableSize(MB)=2 compactionTableSizeMultiplier=1.000
path=/Users/pooh/data/klay/chaindata/header levelDBCacheSize=38 openFilesLimit=256 useBufferPool=true usePerfCheck=true compressionType=none compactionTableSize(MB)=2 compactionTableSizeMultiplier=1.000
path=/Users/pooh/data/klay/chaindata/body levelDBCacheSize=38 openFilesLimit=256 useBufferPool=true usePerfCheck=true compressionType=none compactionTableSize(MB)=2 compactionTableSizeMultiplier=1.000
path=/Users/pooh/data/klay/chaindata/receipts levelDBCacheSize=38 openFilesLimit=256 useBufferPool=true usePerfCheck=true compressionType=none compactionTableSize(MB)=2 compactionTableSizeMultiplier=1.000
path=/Users/pooh/data/klay/chaindata/statetrie/0 levelDBCacheSize=76 openFilesLimit=512 useBufferPool=true usePerfCheck=true compressionType=none compactionTableSize(MB)=2 compactionTableSizeMultiplier=1.000
path=/Users/pooh/data/klay/chaindata/statetrie/1 levelDBCacheSize=76 openFilesLimit=512 useBufferPool=true usePerfCheck=true compressionType=none compactionTableSize(MB)=2 compactionTableSizeMultiplier=1.000
path=/Users/pooh/data/klay/chaindata/statetrie/2 levelDBCacheSize=76 openFilesLimit=512 useBufferPool=true usePerfCheck=true compressionType=none compactionTableSize(MB)=2 compactionTableSizeMultiplier=1.000
path=/Users/pooh/data/klay/chaindata/statetrie/3 levelDBCacheSize=76 openFilesLimit=512 useBufferPool=true usePerfCheck=true compressionType=none compactionTableSize(MB)=2 compactionTableSizeMultiplier=1.000
dbType=statetrie numShards=4
path=/Users/pooh/data/klay/chaindata/txlookup levelDBCacheSize=16 openFilesLimit=102 useBufferPool=true usePerfCheck=true compressionType=none compactionTableSize(MB)=2 compactionTableSizeMultiplier=1.000
path=/Users/pooh/data/klay/chaindata/bridgeservice levelDBCacheSize=16 openFilesLimit=51 useBufferPool=true usePerfCheck=true compressionType=none compactionTableSize(MB)=2 compactionTableSizeMultiplier=1.000
state found in a database
config="{ChainID: 1001 IstanbulCompatibleBlock: 75373312 LondonCompatibleBlock: 80295291 SubGroupSize: 22 UnitPrice: 25000000000 DeriveShaImpl: 2 Engine: istanbul}"
versions=[64] network=1001
from=N/A to=3
br> local trie node cache (fastCache) MaxMiB=1024 FilePath=/Users/pooh/data/fastcache
trie node cache (fastCache) LoadedMiB=0 LoadedEntries=0 elapsed=973.25µs
number=0 hash=e33ff0…bc4b4a td=1 age=2y9mo1w
number=0 hash=e33ff0…bc4b4a td=1 age=2y9mo1w
number=0 hash=e33ff0…bc4b4a td=1 age=2y9mo1w
num=32
transaction journal transactions=0 accounts=0
is used for persistent storage DBType=LevelDB
path=/Users/pooh/data/klay/scchaindata/misc levelDBCacheSize=16 openFilesLimit=16 useBufferPool=false usePerfCheck=false compressionType=none compactionTableSize(MB)=2 compactionTableSizeMultiplier=1.000
path=/Users/pooh/data/klay/scchaindata/header levelDBCacheSize=16 openFilesLimit=16 useBufferPool=false usePerfCheck=false compressionType=none compactionTableSize(MB)=2 compactionTableSizeMultiplier=1.000
path=/Users/pooh/data/klay/scchaindata/body levelDBCacheSize=16 openFilesLimit=16 useBufferPool=false usePerfCheck=false compressionType=none compactionTableSize(MB)=2 compactionTableSizeMultiplier=1.000
path=/Users/pooh/data/klay/scchaindata/receipts levelDBCacheSize=16 openFilesLimit=16 useBufferPool=false usePerfCheck=false compressionType=none compactionTableSize(MB)=2 compactionTableSizeMultiplier=1.000
path=/Users/pooh/data/klay/scchaindata/statetrie levelDBCacheSize=16 openFilesLimit=16 useBufferPool=false usePerfCheck=false compressionType=none compactionTableSize(MB)=2 compactionTableSizeMultiplier=1.000
path=/Users/pooh/data/klay/scchaindata/txlookup levelDBCacheSize=16 openFilesLimit=16 useBufferPool=false usePerfCheck=false compressionType=none compactionTableSize(MB)=2 compactionTableSizeMultiplier=1.000
path=/Users/pooh/data/klay/scchaindata/bridgeservice levelDBCacheSize=16 openFilesLimit=16 useBufferPool=false usePerfCheck=false compressionType=none compactionTableSize(MB)=2 compactionTableSizeMultiplier=1.000
Klaytn-Bridge protocol network=1
namespace=klay
namespace=klay
namespace=klay
namespace=klay
namespace=klay
namespace=klay
namespace=klay
namespace=klay
namespace=klay
networking
protobuf=udp extport=32323 intport=32323 interface=“UPNP IGDv1-IP1”
self=“kni://43ef3db391b670be3ea2922b0a827bb4410bf3b40254e67abb46839b37006f82a5783285da01b6265732d4bce103d783cd160c8ec7cf399902df7bcddb055c98@121.165.82.214:32323?ntype=en”
self=“kni://43ef3db391b670be3ea2922b0a827bb4410bf3b40254e67abb46839b37006f82a5783285da01b6265732d4bce103d783cd160c8ec7cf399902df7bcddb055c98@121.165.82.214:32323?ntype=en”
self=“kni://43ef3db391b670be3ea2922b0a827bb4410bf3b40254e67abb46839b37006f82a5783285da01b6265732d4bce103d783cd160c8ec7cf399902df7bcddb055c98@121.165.82.214:32323?ntype=en”
id=43ef3db391b670be multichannel=true
networking
chain head event to update stakingInfoCache.
id=43ef3db391b670be multichannel=false
self=“kni://43ef3db391b670be3ea2922b0a827bb4410bf3b40254e67abb46839b37006f82a5783285da01b6265732d4bce103d783cd160c8ec7cf399902df7bcddb055c98@[::]:50505?discport=0”
url=/Users/pooh/data/klay.ipc
url=http://0.0.0.0:8551 cors=* vhosts=*
url=ws://0.0.0.0:8552
protobuf=tcp extport=32323 intport=32323 interface=“UPNP IGDv1-IP1”
protobuf=tcp extport=32324 intport=32324 interface=“UPNP IGDv1-IP1”

Pepper · 3월 24, 2022, 4:01오후

안녕하세요. 클레이튼 포럼에 글을 남겨주셔서 감사합니다.
테스트 단계라서 맥북+무선랜을 사용한것이 문제가 될까요? → 이건 문제가 아닐 가능성이 높습니다.
혹시 로그 마지막 부분을 첨부해 주실 수 있을까요?
error나 warn log가 있으면 원인을 파악하는데 도움이 될 것 같습니다. 감사합니다.

akjkcham · 3월 24, 2022, 5:52오후

안녕하세요.

상동에 있는 로그 기록 말고는 더이상 기록되는 로그가 없는 상태입니다
그래서 VERBOSITY=5 로 변경후 다시 로그를 확인했습니다.
초기 기동시 출력되는 에러로그
ERROR[03/25,02:05:37 +09] [45] p2p rpc registered namespace=klay
실행중에 출력되는 RPC timeout
TRACE[03/25,02:18:55 +09] [34] Bond Discover=Table error=“RPC timeout”
실행중에는 2번 내용을 반복적으로 출력하고 있습니다. (kend.out 로그는 맨아래 있습니다)

그리고 제가 설정한 부분은 다음과 같습니다.

conf → kend_baobab.conf 파일 kend.conf 변경
kend.conf 설정 변경
NETWORK=“baobab”
SC_MAIN_BRIDGE=1
DATA_DIR=~/data
제네시스 노드 생성
curl -X GET https://packages.klaytn.net/baobab/genesis.json -o ~/genesis.json
ken --datadir ~/data init ~/genesis.json
kend start

사용하는 버전이나 머신이 문제가 없다면 제가 뭔가 설정을 잘못하거나 빼먹은거 같은데 제가 좀더 확인할 부분이 있을까요?

답변 부탁드립니다.
감사합니다.

kend.out 로그입니다(일부만 발췌)
############################
시작될때 에러로그
############################
ERROR[03/25,02:05:37 +09] [45] p2p rpc registered namespace=klay
ERROR[03/25,02:05:37 +09] [45] p2p rpc registered namespace=klay
ERROR[03/25,02:05:37 +09] [45] p2p rpc registered namespace=klay
ERROR[03/25,02:05:37 +09] [45] p2p rpc registered namespace=klay
ERROR[03/25,02:05:37 +09] [45] p2p rpc registered namespace=klay
ERROR[03/25,02:05:37 +09] [45] p2p rpc registered namespace=klay
ERROR[03/25,02:05:37 +09] [45] p2p rpc registered namespace=klay
ERROR[03/25,02:05:37 +09] [45] p2p rpc registered namespace=klay
ERROR[03/25,02:05:37 +09] [45] p2p rpc registered namespace=klay
############################
실행중 로그
############################
TRACE[03/25,02:19:11 +09] [33] [Dial] discoverTypedStaticTask - done t.name=PN result count=0
TRACE[03/25,02:19:11 +09] [33] [Dial] Dynamic Dials Remained Capacity needDynDials=3 maxDynDials=3
DEBUG[03/25,02:19:11 +09] [33] [Dial] Add new discoverTypedStaticTask name=PN
TRACE[03/25,02:19:11 +09] [40] New dial task task=“discover TypedStaticTask: max: 2”
DEBUG[03/25,02:19:11 +09] [34] lookup start Discover=Kademlia StorageName=EN targetID=43ef3db391b670be targetNodeType=EN refreshIfEmpty=false
DEBUG[03/25,02:19:11 +09] [34] findNewNode: found nodes Discover=Table length=0 nodeType=3
DEBUG[03/25,02:19:11 +09] [34] lookup start Discover=Kademlia StorageName=EN targetID=4e1510fc99abc96a targetNodeType=EN refreshIfEmpty=false
DEBUG[03/25,02:19:11 +09] [34] findNewNode: found nodes Discover=Table length=0 nodeType=3
DEBUG[03/25,02:19:11 +09] [34] lookup start Discover=Kademlia StorageName=EN targetID=06886f472bb79d11 targetNodeType=EN refreshIfEmpty=false
DEBUG[03/25,02:19:11 +09] [34] findNewNode: found nodes Discover=Table length=0 nodeType=3
DEBUG[03/25,02:19:11 +09] [34] lookup start Discover=Kademlia StorageName=EN targetID=af80080ba770a533 targetNodeType=EN refreshIfEmpty=false
DEBUG[03/25,02:19:11 +09] [34] findNewNode: found nodes Discover=Table length=0 nodeType=3
DEBUG[03/25,02:19:11 +09] [34] findNewNode: found nodes Discover=Table length=0 nodeType=3
TRACE[03/25,02:19:11 +09] [40] Dial task done task=“discovery lookup”
TRACE[03/25,02:19:11 +09] [33] [Dial] Dynamic Dials Remained Capacity needDynDials=3 maxDynDials=3
TRACE[03/25,02:19:11 +09] [40] New dial task task=“discovery lookup”
TRACE[03/25,02:19:11 +09] [33] discoverTask sleep period=3.493530584s
TRACE[03/25,02:19:14 +09] [33] discoverTask wakeup
DEBUG[03/25,02:19:14 +09] [34] lookup start Discover=Kademlia StorageName=EN targetID=dff5e73724fd1c20 targetNodeType=EN refreshIfEmpty=true
TRACE[03/25,02:19:14 +09] [34] doRefresh() Discover=Table
TRACE[03/25,02:19:14 +09] [34] Bond - Starting bonding ping/pong Discover=Table id=779d766628247ebd known=false failcount=0 age=457817h19m14.781686s
TRACE[03/25,02:19:14 +09] [34] ping Discover=Table to=779d766628247ebd
TRACE[03/25,02:19:14 +09] [34] >> PING/v4 addr=52.79.223.199:32323 err=nil
TRACE[03/25,02:19:14 +09] [34] Bond - Starting bonding ping/pong Discover=Table id=779d766628247ebd known=false failcount=0 age=457817h19m14.787126s
TRACE[03/25,02:19:15 +09] [34] Bond Discover=Table error=“RPC timeout”
DEBUG[03/25,02:19:15 +09] [34] lookup Discover=Simple StorageName=PN targetId=0000000000000000 targetType=PN
DEBUG[03/25,02:19:15 +09] [34] findNewNode: found nodes Discover=Table length=0 nodeType=2
TRACE[03/25,02:19:15 +09] [33] discoverTypedStaticTask result=0
TRACE[03/25,02:19:15 +09] [34] Bond Discover=Table error=“RPC timeout”
DEBUG[03/25,02:19:15 +09] [34] lookup start Discover=Kademlia StorageName=EN targetID=43ef3db391b670be targetNodeType=EN refreshIfEmpty=false
DEBUG[03/25,02:19:15 +09] [34] findNewNode: found nodes Discover=Table length=0 nodeType=3
DEBUG[03/25,02:19:15 +09] [34] lookup start Discover=Kademlia StorageName=EN targetID=2660f042a00414c6 targetNodeType=EN refreshIfEmpty=false
DEBUG[03/25,02:19:15 +09] [34] findNewNode: found nodes Discover=Table length=0 nodeType=3
DEBUG[03/25,02:19:15 +09] [34] lookup start Discover=Kademlia StorageName=EN targetID=670be265ab09b046 targetNodeType=EN refreshIfEmpty=false
DEBUG[03/25,02:19:15 +09] [34] findNewNode: found nodes Discover=Table length=0 nodeType=3
DEBUG[03/25,02:19:15 +09] [34] lookup start Discover=Kademlia StorageName=EN targetID=e9b4c6b2534bee05 targetNodeType=EN refreshIfEmpty=false
DEBUG[03/25,02:19:15 +09] [34] findNewNode: found nodes Discover=Table length=0 nodeType=3
TRACE[03/25,02:19:15 +09] [40] Dial task done task=“discover TypedStaticTask: max: 2”
TRACE[03/25,02:19:15 +09] [33] [Dial] discoverTypedStaticTask - done t.name=PN result count=0
TRACE[03/25,02:19:15 +09] [33] [Dial] Dynamic Dials Remained Capacity needDynDials=3 maxDynDials=3
DEBUG[03/25,02:19:15 +09] [33] [Dial] Add new discoverTypedStaticTask name=PN
DEBUG[03/25,02:19:15 +09] [34] findNewNode: found nodes Discover=Table length=0 nodeType=3
TRACE[03/25,02:19:15 +09] [40] New dial task task=“discover TypedStaticTask: max: 2”
TRACE[03/25,02:19:15 +09] [40] Dial task done task=“discovery lookup”
TRACE[03/25,02:19:15 +09] [33] [Dial] Dynamic Dials Remained Capacity needDynDials=3 maxDynDials=3
TRACE[03/25,02:19:15 +09] [40] New dial task task=“discovery lookup”
TRACE[03/25,02:19:15 +09] [33] discoverTask sleep period=3.493701459s
TRACE[03/25,02:19:18 +09] [33] discoverTask wakeup
DEBUG[03/25,02:19:18 +09] [34] lookup start Discover=Kademlia StorageName=EN targetID=705042a3be0e1b99 targetNodeType=EN refreshIfEmpty=true
TRACE[03/25,02:19:18 +09] [34] doRefresh() Discover=Table
TRACE[03/25,02:19:18 +09] [34] Bond - Starting bonding ping/pong Discover=Table id=779d766628247ebd known=false failcount=0 age=457817h19m18.783908s
TRACE[03/25,02:19:18 +09] [34] ping Discover=Table to=779d766628247ebd
TRACE[03/25,02:19:18 +09] [34] >> PING/v4 addr=52.79.223.199:32323 err=nil
TRACE[03/25,02:19:18 +09] [34] Bond - Starting bonding ping/pong Discover=Table id=779d766628247ebd known=false failcount=0 age=457817h19m18.787797s
TRACE[03/25,02:19:19 +09] [34] Bond Discover=Table error=“RPC timeout”
DEBUG[03/25,02:19:19 +09] [34] lookup Discover=Simple StorageName=PN targetId=0000000000000000 targetType=PN
DEBUG[03/25,02:19:19 +09] [34] findNewNode: found nodes Discover=Table length=0 nodeType=2
TRACE[03/25,02:19:19 +09] [33] discoverTypedStaticTask result=0
TRACE[03/25,02:19:19 +09] [40] Dial task done task=“discover TypedStaticTask: max: 2”
TRACE[03/25,02:19:19 +09] [33] [Dial] discoverTypedStaticTask - done t.name=PN result count=0
TRACE[03/25,02:19:19 +09] [33] [Dial] Dynamic Dials Remained Capacity needDynDials=3 maxDynDials=3
DEBUG[03/25,02:19:19 +09] [33] [Dial] Add new discoverTypedStaticTask name=PN
TRACE[03/25,02:19:19 +09] [34] Bond Discover=Table error=“RPC timeout”
DEBUG[03/25,02:19:19 +09] [34] lookup start Discover=Kademlia StorageName=EN targetID=43ef3db391b670be targetNodeType=EN refreshIfEmpty=false
DEBUG[03/25,02:19:19 +09] [34] findNewNode: found nodes Discover=Table length=0 nodeType=3
DEBUG[03/25,02:19:19 +09] [34] lookup start Discover=Kademlia StorageName=EN targetID=d161e8ad46cbb055 targetNodeType=EN refreshIfEmpty=false
DEBUG[03/25,02:19:19 +09] [34] findNewNode: found nodes Discover=Table length=0 nodeType=3
DEBUG[03/25,02:19:19 +09] [34] lookup start Discover=Kademlia StorageName=EN targetID=6db23ded0bc45e26 targetNodeType=EN refreshIfEmpty=false
DEBUG[03/25,02:19:19 +09] [34] findNewNode: found nodes Discover=Table length=0 nodeType=3
DEBUG[03/25,02:19:19 +09] [34] lookup start Discover=Kademlia StorageName=EN targetID=d7dc23d405868be1 targetNodeType=EN refreshIfEmpty=false
DEBUG[03/25,02:19:19 +09] [34] findNewNode: found nodes Discover=Table length=0 nodeType=3
DEBUG[03/25,02:19:19 +09] [34] findNewNode: found nodes Discover=Table length=0 nodeType=3
TRACE[03/25,02:19:19 +09] [40] New dial task task=“discover TypedStaticTask: max: 2”
TRACE[03/25,02:19:19 +09] [40] Dial task done task=“discovery lookup”
TRACE[03/25,02:19:19 +09] [33] [Dial] Dynamic Dials Remained Capacity needDynDials=3 maxDynDials=3
TRACE[03/25,02:19:19 +09] [40] New dial task task=“discovery lookup”
TRACE[03/25,02:19:19 +09] [33] discoverTask sleep period=3.49383725s
TRACE[03/25,02:19:22 +09] [33] discoverTask wakeup
DEBUG[03/25,02:19:22 +09] [34] lookup start Discover=Kademlia StorageName=EN targetID=2aa1f6a963b71751 targetNodeType=EN refreshIfEmpty=true
TRACE[03/25,02:19:22 +09] [34] doRefresh() Discover=Table
TRACE[03/25,02:19:22 +09] [34] Bond - Starting bonding ping/pong Discover=Table id=779d766628247ebd known=false failcount=0 age=457817h19m22.786779s
TRACE[03/25,02:19:22 +09] [34] ping Discover=Table to=779d766628247ebd
TRACE[03/25,02:19:22 +09] [34] >> PING/v4 addr=52.79.223.199:32323 err=nil
TRACE[03/25,02:19:22 +09] [34] Bond - Starting bonding ping/pong Discover=Table id=779d766628247ebd known=false failcount=0 age=457817h19m22.7902s
TRACE[03/25,02:19:23 +09] [34] Bond Discover=Table error=“RPC timeout”
DEBUG[03/25,02:19:23 +09] [34] lookup Discover=Simple StorageName=PN targetId=0000000000000000 targetType=PN
DEBUG[03/25,02:19:23 +09] [34] findNewNode: found nodes Discover=Table length=0 nodeType=2
TRACE[03/25,02:19:23 +09] [33] discoverTypedStaticTask result=0
TRACE[03/25,02:19:23 +09] [40] Dial task done task=“discover TypedStaticTask: max: 2”
TRACE[03/25,02:19:23 +09] [33] [Dial] discoverTypedStaticTask - done t.name=PN result count=0
TRACE[03/25,02:19:23 +09] [33] [Dial] Dynamic Dials Remained Capacity needDynDials=3 maxDynDials=3
DEBUG[03/25,02:19:23 +09] [33] [Dial] Add new discoverTypedStaticTask name=PN
TRACE[03/25,02:19:23 +09] [40] New dial task task=“discover TypedStaticTask: max: 2”
TRACE[03/25,02:19:23 +09] [34] Bond Discover=Table error=“RPC timeout”
DEBUG[03/25,02:19:23 +09] [34] lookup start Discover=Kademlia StorageName=EN targetID=43ef3db391b670be targetNodeType=EN refreshIfEmpty=false
DEBUG[03/25,02:19:23 +09] [34] findNewNode: found nodes Discover=Table length=0 nodeType=3
DEBUG[03/25,02:19:23 +09] [34] lookup start Discover=Kademlia StorageName=EN targetID=6754cbda4b90a103 targetNodeType=EN refreshIfEmpty=false
DEBUG[03/25,02:19:23 +09] [34] findNewNode: found nodes Discover=Table length=0 nodeType=3
DEBUG[03/25,02:19:23 +09] [34] lookup start Discover=Kademlia StorageName=EN targetID=f6661d9a09708951 targetNodeType=EN refreshIfEmpty=false
DEBUG[03/25,02:19:23 +09] [34] findNewNode: found nodes Discover=Table length=0 nodeType=3
DEBUG[03/25,02:19:23 +09] [34] lookup start Discover=Kademlia StorageName=EN targetID=9bd9c636e3ad28a9 targetNodeType=EN refreshIfEmpty=false
DEBUG[03/25,02:19:23 +09] [34] findNewNode: found nodes Discover=Table length=0 nodeType=3
DEBUG[03/25,02:19:23 +09] [34] findNewNode: found nodes Discover=Table length=0 nodeType=3
TRACE[03/25,02:19:23 +09] [40] Dial task done task=“discovery lookup”
TRACE[03/25,02:19:23 +09] [33] [Dial] Dynamic Dials Remained Capacity needDynDials=3 maxDynDials=3
TRACE[03/25,02:19:23 +09] [40] New dial task task=“discovery lookup”
TRACE[03/25,02:19:23 +09] [33] discoverTask sleep period=3.489959875s
TRACE[03/25,02:19:26 +09] [33] discoverTask wakeup
DEBUG[03/25,02:19:26 +09] [34] lookup start Discover=Kademlia StorageName=EN targetID=c128d9fb629714b0 targetNodeType=EN refreshIfEmpty=true
TRACE[03/25,02:19:26 +09] [34] Bond - Starting bonding ping/pong Discover=Table id=779d766628247ebd known=false failcount=0 age=457817h19m26.786915s
TRACE[03/25,02:19:26 +09] [34] ping Discover=Table to=779d766628247ebd
TRACE[03/25,02:19:26 +09] [34] doRefresh() Discover=Table
TRACE[03/25,02:19:26 +09] [34] >> PING/v4 addr=52.79.223.199:32323 err=nil
TRACE[03/25,02:19:26 +09] [34] Bond - Starting bonding ping/pong Discover=Table id=779d766628247ebd known=false failcount=0 age=457817h19m26.791002s
TRACE[03/25,02:19:27 +09] [34] Bond Discover=Table error=“RPC timeout”
DEBUG[03/25,02:19:27 +09] [34] lookup Discover=Simple StorageName=PN targetId=0000000000000000 targetType=PN
DEBUG[03/25,02:19:27 +09] [34] findNewNode: found nodes Discover=Table length=0 nodeType=2
TRACE[03/25,02:19:27 +09] [33] discoverTypedStaticTask result=0
TRACE[03/25,02:19:27 +09] [40] Dial task done task=“discover TypedStaticTask: max: 2”
TRACE[03/25,02:19:27 +09] [33] [Dial] discoverTypedStaticTask - done t.name=PN result count=0
TRACE[03/25,02:19:27 +09] [33] [Dial] Dynamic Dials Remained Capacity needDynDials=3 maxDynDials=3
DEBUG[03/25,02:19:27 +09] [33] [Dial] Add new discoverTypedStaticTask name=PN
TRACE[03/25,02:19:27 +09] [40] New dial task task=“discover TypedStaticTask: max: 2”
TRACE[03/25,02:19:27 +09] [34] Bond Discover=Table error=“RPC timeout”
DEBUG[03/25,02:19:27 +09] [34] lookup start Discover=Kademlia StorageName=EN targetID=43ef3db391b670be targetNodeType=EN refreshIfEmpty=false
DEBUG[03/25,02:19:27 +09] [34] findNewNode: found nodes Discover=Table length=0 nodeType=3
DEBUG[03/25,02:19:27 +09] [34] lookup start Discover=Kademlia StorageName=EN targetID=68963070db7a90cb targetNodeType=EN refreshIfEmpty=false
DEBUG[03/25,02:19:27 +09] [34] findNewNode: found nodes Discover=Table length=0 nodeType=3
DEBUG[03/25,02:19:27 +09] [34] lookup start Discover=Kademlia StorageName=EN targetID=cfabb4497b51f40f targetNodeType=EN refreshIfEmpty=false
DEBUG[03/25,02:19:27 +09] [34] findNewNode: found nodes Discover=Table length=0 nodeType=3
DEBUG[03/25,02:19:27 +09] [34] lookup start Discover=Kademlia StorageName=EN targetID=65fe60ef46e343c1 targetNodeType=EN refreshIfEmpty=false
DEBUG[03/25,02:19:27 +09] [34] findNewNode: found nodes Discover=Table length=0 nodeType=3
DEBUG[03/25,02:19:27 +09] [34] findNewNode: found nodes Discover=Table length=0 nodeType=3
TRACE[03/25,02:19:27 +09] [40] Dial task done task=“discovery lookup”
TRACE[03/25,02:19:27 +09] [33] [Dial] Dynamic Dials Remained Capacity needDynDials=3 maxDynDials=3

Aidan · 3월 25, 2022, 1:50오전

@akjkcham Baobab bootnode에 이슈가 있었습니다. 현재 해결되었는데, 한번 다시 동기화 시도해보시겠어요?

akjkcham · 3월 25, 2022, 2:36오전

다시 재기동하니 정상적으로 블럭싱크가 동작합니다ㅠㅠ

감사합니다 ( _ _ )

akjkcham · 3월 25, 2022, 7:48오전

다시 블록싱크가 안되는거 같습니다

다음은 kend.out 로그 입니다.

WARN[03/25,16:43:01 +09] [28] Synchronisation failed, dropping peer peer=132d7e00f49b36bc err=timeout
INFO[03/25,16:43:01 +09] [33] Added a multichannel P2P Peer id=132d7e00f49b36bc conn=trusted-staticdial peerID=132d7e00f49b36bc
INFO[03/25,16:43:02 +09] [33] Added a multichannel P2P Peer id=6fe9b491a3678189 conn=inbound peerID=6fe9b491a3678189
WARN[03/25,16:43:06 +09] [33] ProtocolManager failed to read msg id=6fe9b491a3678189 conn=inbound err=EOF
WARN[03/25,16:43:06 +09] [33] ProtocolManager failed to read msg id=6fe9b491a3678189 conn=inbound err=EOF
INFO[03/25,16:43:06 +09] [33] Disconnected a multichannel P2P Peer id=6fe9b491a3678189 conn=inbound peerID=6fe9b491a3678189 peerName=Klaytn/v1.7.1+86d60fe05b/linux-amd64/go1.15.7 err=EOF
ERROR[03/25,16:43:06 +09] [33] ProtocolManager failed to handle message id=6fe9b491a3678189 conn=inbound msg=“msg #7 (10 bytes)” err=“shutting down”
ERROR[03/25,16:43:07 +09] [33] ProtocolManager failed to handle message id=132d7e00f49b36bc conn=trusted-staticdial msg=“msg #10 (2325 bytes)” err=“Invalid message - msg msg #10 (2325 bytes): invalid message: (code a) (size 2325) undefined tx type”
INFO[03/25,16:43:20 +09] [33] Added a single channel P2P Peer id=b0c555bd1e901e27 conn=inbound peerID=b0c555bd1e901e27
ERROR[03/25,16:43:20 +09] [33] ProtocolManager failed to handle message id=b0c555bd1e901e27 conn=inbound msg=“msg #10 (4410 bytes)” err=“Invalid message - msg msg #10 (4410 bytes): invalid message: (code a) (size 4410) undefined tx type”
ERROR[03/25,16:43:21 +09] [33] Protocol istanbul/64 failed id=b0c555bd1e901e27 conn=inbound err=“Invalid message - msg msg #10 (4410 bytes): invalid message: (code a) (size 4410) undefined tx type”
WARN[03/25,16:43:34 +09] [40] Failed doConnTypeHandshake addr=3.38.240.30:3331 conn=inbound conntype=-1 err=“read tcp 172.30.1.50:32324->3.38.240.30:3331: i/o timeout”
INFO[03/25,16:44:01 +09] [28] Downloader queue stats receiptTasks=0 blockTasks=157 itemSize=0.00B throttle=8192
WARN[03/25,16:44:01 +09] [28] Synchronisation failed, dropping peer peer=132d7e00f49b36bc err=timeout
WARN[03/25,16:44:01 +09] [33] ProtocolManager failed to read msg id=132d7e00f49b36bc conn=trusted-staticdial err=EOF
WARN[03/25,16:44:01 +09] [33] ProtocolManager failed to read msg id=26e7de5192e61953 conn=trusted-staticdial err=EOF
INFO[03/25,16:44:01 +09] [33] Disconnected a multichannel P2P Peer id=26e7de5192e61953 conn=trusted-staticdial peerID=26e7de5192e61953 peerName=Klaytn/v1.8.1/linux-amd64/go1.15.7 err=“Invalid message - msg msg #10 (2325 bytes): invalid message: (code a) (size 2325) undefined tx type”
ERROR[03/25,16:44:01 +09] [33] Protocol istanbul/64 failed id=26e7de5192e61953 conn=trusted-staticdial err=“Invalid message - msg msg #10 (2325 bytes): invalid message: (code a) (size 2325) undefined tx type”
INFO[03/25,16:44:01 +09] [33] [Dial] Add dial candidate from static nodes id=26e7de5192e61953 NodeType=2 ip=15.164.78.160 mainPort=32323 port="[32323 32324]"
INFO[03/25,16:44:01 +09] [33] Disconnected a multichannel P2P Peer id=132d7e00f49b36bc conn=trusted-staticdial peerID=132d7e00f49b36bc peerName=Klaytn/v1.8.1/linux-amd64/go1.15.7 err=“Invalid message - msg msg #10 (2325 bytes): invalid message: (code a) (size 2325) undefined tx type”
ERROR[03/25,16:44:01 +09] [33] Protocol istanbul/64 failed id=132d7e00f49b36bc conn=trusted-staticdial err=“Invalid message - msg msg #10 (2325 bytes): invalid message: (code a) (size 2325) undefined tx type”
INFO[03/25,16:44:01 +09] [33] [Dial] Add dial candidate from static nodes id=132d7e00f49b36bc NodeType=2 ip=15.164.82.77 mainPort=32323 port="[32323 32324]"
INFO[03/25,16:44:01 +09] [33] Added a multichannel P2P Peer id=26e7de5192e61953 conn=trusted-staticdial peerID=26e7de5192e61953
ERROR[03/25,16:44:04 +09] [33] ProtocolManager failed to handle message id=26e7de5192e61953 conn=trusted-staticdial msg=“msg #10 (6077 bytes)” err=“Invalid message - msg msg #10 (6077 bytes): invalid message: (code a) (size 6077) undefined tx type”
INFO[03/25,16:44:12 +09] [33] Added a single channel P2P Peer id=026bf3c2c005375f conn=dyndial peerID=026bf3c2c005375f
ERROR[03/25,16:44:12 +09] [33] ProtocolManager failed to handle message id=026bf3c2c005375f conn=dyndial msg=“msg #10 (2325 bytes)” err=“Invalid message - msg msg #10 (2325 bytes): invalid message: (code a) (size 2325) undefined tx type”
ERROR[03/25,16:44:12 +09] [33] Protocol istanbul/64 failed id=026bf3c2c005375f conn=dyndial err=“Invalid message - msg msg #10 (2325 bytes): invalid message: (code a) (size 2325) undefined tx type”
INFO[03/25,16:44:37 +09] [33] [Dial] Add dial candidate from static nodes id=132d7e00f49b36bc NodeType=2 ip=15.164.82.77 mainPort=32323 port="[32323 32324]"
INFO[03/25,16:44:37 +09] [33] Added a multichannel P2P Peer id=132d7e00f49b36bc conn=trusted-staticdial peerID=132d7e00f49b36bc
ERROR[03/25,16:44:37 +09] [33] ProtocolManager failed to handle message id=132d7e00f49b36bc conn=trusted-staticdial msg=“msg #10 (2325 bytes)” err=“Invalid message - msg msg #10 (2325 bytes): invalid message: (code a) (size 2325) undefined tx type”
INFO[03/25,16:45:02 +09] [28] Downloader queue stats receiptTasks=0 blockTasks=366 itemSize=0.00B throttle=8192
WARN[03/25,16:45:03 +09] [28] Synchronisation failed, dropping peer peer=26e7de5192e61953 err=timeout
WARN[03/25,16:45:03 +09] [33] ProtocolManager failed to read msg id=26e7de5192e61953 conn=trusted-staticdial err=EOF
INFO[03/25,16:45:03 +09] [33] Disconnected a multichannel P2P Peer id=26e7de5192e61953 conn=trusted-staticdial peerID=26e7de5192e61953 peerName=Klaytn/v1.8.1/linux-amd64/go1.15.7 err=“Invalid message - msg msg #10 (6077 bytes): invalid message: (code a) (size 6077) undefined tx type”
ERROR[03/25,16:45:03 +09] [33] Protocol istanbul/64 failed id=26e7de5192e61953 conn=trusted-staticdial err=“Invalid message - msg msg #10 (6077 bytes): invalid message: (code a) (size 6077) undefined tx type”
INFO[03/25,16:45:03 +09] [33] [Dial] Add dial candidate from static nodes id=26e7de5192e61953 NodeType=2 ip=15.164.78.160 mainPort=32323 port="[32323 32324]"
INFO[03/25,16:45:03 +09] [33] Added a multichannel P2P Peer id=26e7de5192e61953 conn=trusted-staticdial peerID=26e7de5192e61953
ERROR[03/25,16:45:11 +09] [33] ProtocolManager failed to handle message id=26e7de5192e61953 conn=trusted-staticdial msg=“msg #10 (6077 bytes)” err=“Invalid message - msg msg #10 (6077 bytes): invalid message: (code a) (size 6077) undefined tx type”
INFO[03/25,16:45:17 +09] [33] Added a single channel P2P Peer id=7e549f067ac4ae1a conn=inbound peerID=7e549f067ac4ae1a
ERROR[03/25,16:45:17 +09] [33] ProtocolManager failed to handle message id=7e549f067ac4ae1a conn=inbound msg=“msg #10 (4410 bytes)” err=“Invalid message - msg msg #10 (4410 bytes): invalid message: (code a) (size 4410) undefined tx type”
ERROR[03/25,16:45:18 +09] [33] Protocol istanbul/64 failed id=7e549f067ac4ae1a conn=inbound err=“Invalid message - msg msg #10 (4410 bytes): invalid message: (code a) (size 4410) undefined tx type”
INFO[03/25,16:45:58 +09] [33] Added a multichannel P2P Peer id=ed8d89444c0209c2 conn=inbound peerID=ed8d89444c0209c2
INFO[03/25,16:46:11 +09] [28] Downloader queue stats receiptTasks=0 blockTasks=31 itemSize=0.00B throttle=8192
WARN[03/25,16:46:11 +09] [28] Synchronisation failed, dropping peer peer=26e7de5192e61953 err=timeout
WARN[03/25,16:46:11 +09] [33] ProtocolManager failed to read msg id=26e7de5192e61953 conn=trusted-staticdial err=EOF
INFO[03/25,16:46:11 +09] [33] Disconnected a multichannel P2P Peer id=26e7de5192e61953 conn=trusted-staticdial peerID=26e7de5192e61953 peerName=Klaytn/v1.8.1/linux-amd64/go1.15.7 err=“Invalid message - msg msg #10 (6077 bytes): invalid message: (code a) (size 6077) undefined tx type”
ERROR[03/25,16:46:11 +09] [33] Protocol istanbul/64 failed id=26e7de5192e61953 conn=trusted-staticdial err=“Invalid message - msg msg #10 (6077 bytes): invalid message: (code a) (size 6077) undefined tx type”
INFO[03/25,16:46:11 +09] [33] [Dial] Add dial candidate from static nodes id=26e7de5192e61953 NodeType=2 ip=15.164.78.160 mainPort=32323 port="[32323 32324]"
INFO[03/25,16:46:11 +09] [33] Added a multichannel P2P Peer id=26e7de5192e61953 conn=trusted-staticdial peerID=26e7de5192e61953
WARN[03/25,16:46:16 +09] [40] Failed doConnTypeHandshake addr=142.132.132.148:53408 conn=inbound conntype=-1 err=“read tcp 172.30.1.50:32324->142.132.132.148:53408: i/o timeout”
ERROR[03/25,16:46:20 +09] [33] ProtocolManager failed to handle message id=26e7de5192e61953 conn=trusted-staticdial msg=“msg #10 (6077 bytes)” err=“Invalid message - msg msg #10 (6077 bytes): invalid message: (code a) (size 6077) undefined tx type”

Aidan · 3월 25, 2022, 8:03오전

v1.7.3 버전을 사용하고 계시군요.
v1.8.0 릴리즈 노트 등에 나와 있듯이 Baobab은 86513895 블록에서 프로토콜 업데이트로 인한 하드포크가 있습니다. 따라서, v1.8.0 이상 버전을 사용하셔야합니다.

현재 최신 버전인 v1.8.2로 바이너리만 업데이트해주시고, 재시작하시면 다시 정상적으로 싱크가 동작할 것입니다.
v1.8.0 릴리즈 노트 하단에 있는 주의사항도 꼭 읽어주시길 바랍니다.

감사합니다.

akjkcham · 3월 26, 2022, 8:56오전

v1.8.0으로 업데이트하고 정상적으로 싱크가 작동합니다.

감사합니다.

글		댓글	조회수
En 실행 에러에 대해 질문드려요 Kaia	3	300	12월 13, 2022
Klaytn baobab EN node 설치 시간이 얼마나 걸리나요? Kaia klaytn	2	251	11월 20, 2021
Klaytn(cypress)와 저희 서비스 체인 앵커링 문의 KAS (아카이브) klaytn	9	2938	1월 26, 2021
Klaytn v1.9.0 문의 Kaia klaytn	3	271	8월 11, 2022
컨트랙트 배포 후 테스트 시 오류가 발생하여 문의드립니다 Kaia	9	989	8월 26, 2021

En 서버에서 동기화 진행이 안되는 문제

Related topics