Skip to content

GitLab

  • Projects
  • Groups
  • Snippets
  • Help
    • Loading...
  • Sign in
issue
issue
  • Project overview
    • Project overview
    • Details
    • Activity
    • Releases
  • Repository
    • Repository
    • Files
    • Commits
    • Branches
    • Tags
    • Contributors
    • Graph
    • Compare
  • Issues 23
    • Issues 23
    • List
    • Boards
    • Labels
    • Service Desk
    • Milestones
  • Wiki
    • Wiki
  • Snippets
    • Snippets
  • Members
    • Members
  • Activity
  • Graph
  • Create a new issue
  • Commits
  • Issue Boards
Collapse sidebar

新注册的用户请输入邮箱并保存,随后登录邮箱激活账号。后续可直接使用邮箱登录!

  • chainmaker
  • issueissue
  • Issues
  • #577

Closed
Open
Opened Mar 10, 2023 by sen zhang@sengle1 of 19 tasks completed1/19 tasks

某个节点的某笔交易超时失败后,该节点便无法同步数据

【问题分类】

  • bug
  • P2P网络相关(包含libp2p,liquid)
  • 链账户身份与权限相关(证书问题、public、多签投票问题)
  • 核心交易引擎相关(交易池、DAG)
  • 共识相关
  • 智能合约相关
  • 存储相关
  • SDK相关
  • 长安链CMC工具
  • 长安链管理台
  • 长安链浏览器
  • 长安链合约IDE
  • 长安链web签名插件
  • 跨链相关
  • 轻节点相关
  • 隐私计算相关
  • 密码学相关
  • 环境依赖
  • 其他补充:

【问题描述】(请对问题进行描述,方便定位问题)

具体的现象,操作步骤,前置条件等,尽可能描述清楚,有截图说明更佳

node4在执行高度为162的交易时,报超时错误,相关日志如下:

2023-03-08 17:15:16.157	[INFO]	[Consensus] [31;1m@chain1[0m	v2@v2.3.2/tbft_status_broadcaster.go:193	[QmQPN36BtUHqJUSr1oihopZa25i5ZZeJH5FKyaX9XPs1RQ](162/62/PROPOSE) send state to [QmYBidYZM7AtQzanxhprenToZvEUTK99kUEYfC9W9q5yRH](163/0/PROPOSE)
2023-03-08 17:15:16.157	[INFO]	[Consensus] [31;1m@chain1[0m	v2@v2.3.2/tbft_status_broadcaster.go:193	[QmQPN36BtUHqJUSr1oihopZa25i5ZZeJH5FKyaX9XPs1RQ](162/62/PROPOSE) send state to [QmbfRmCpht135LTWkHXE4UWKVknMGLfsLaNs4pXm2CLfkz](163/0/PROPOSE)
2023-03-08 17:15:16.351	[ERROR]	[Vm] [31;1m@chain1[0m	v2@v2.3.2/runtime.go:228	handle tx [174a66dc1675e905ca88e298bad140b33403439a4bd84c3987f5cc2e4318a5ab] failed, fail to receive response in 9 secs and return timeout response, <step: "RUNTIME_PREPARE_TX_REQUEST", start time: 2023-03-08 17:15:07.348441215 +0800 CST, step cost: 0.022187ms, until cost: 0.021436ms, msg: pos:0> <step: "RUNTIME_GRPC_SEND_TX_REQUEST", start time: 2023-03-08 17:15:07.348465948 +0800 CST, step cost: 0ms, until cost: 0ms, msg: msgSize:625> 
2023-03-08 17:15:16.352	[INFO]	[Vm] [31;1m@chain1[0m	v2@v2.3.2/runtime.go:231	174a66dc1675e905ca88e298bad140b33403439a4bd84c3987f5cc2e4318a5ab#173 spend time: 0μs, syscall: 0μs(count: 0), r/w store: 0μs, possible syscall: 4μs(count: 1), cross contract: 0μs(count: 0)
2023-03-08 17:15:16.352	[INFO]	[Vm] [31;1m@chain1[0m	v2@v2.3.2/runtime.go:232	GET_BYTECODE_REQUEST start: 2023-03-08 17:15:07.350495589 +0800 CST, spend: 4μs, r/w store: 0μs; 
2023-03-08 17:15:16.352	[INFO]	[Storage] [31;1m@chain1[0m	v2@v2.3.2/sqldbtx.go:299	db tx[a085fdde81c205c3b3cf0cccd3ccd88957d39e23428971ecd067ac91bcbfe646] rollback savepoint[SP_174a66dc1675e905ca88e298bad140b33403439a4bd84c3987f5cc2e4318a5ab],result:%!s(<nil>)
2023-03-08 17:15:16.353	[ERROR]	[Core] [31;1m@chain1[0m	scheduler/scheduler.go:615	failed to run vm for tx id:174a66dc1675e905ca88e298bad140b33403439a4bd84c3987f5cc2e4318a5ab,contractName:CONTRACT_MANAGE, tx result:code:CONTRACT_FAIL contract_result:<code:1 message:"contract initial fail, tx timeout" > , error:contract initial fail, tx timeout
2023-03-08 17:15:16.353	[INFO]	[Core] [31;1m@chain1[0m	scheduler/scheduler.go:478	simulate with dag finished, block 162, size 1, time used 9.345827951s, tps 0.1069996157903806
2023-03-08 17:15:16.353	[INFO]	[Snapshot] [31;1m@chain1[0m	snapshot/snapshot_impl.go:474	start to build DAG for block 162 with 1 txs
2023-03-08 17:15:16.353	[INFO]	[Core] [31;1m@chain1[0m	scheduler/scheduler.go:1506	compare dag finished, time used 18.576µs
2023-03-08 17:15:16.353	[INFO]	[Vm] [31;1m@chain1[0m	v2@v2.3.2/instance_manager.go:160	BlockHeight: 162,  spend time: 9004249μs, syscall: 0μs(count: 0), r/w store: 0μs, possible syscall: 8μs(count: 2), cross contract: 0μs(count: 0)
2023-03-08 17:15:16.353	[INFO]	[Core] [31;1m@chain1[0m	common/block_helper.go:692	Validate block[162](txs:1), time used(new snapshot:1, start DB transaction:0, vm:9346)
2023-03-08 17:15:16.353	[INFO]	[TxPool] [31;1m@chain1[0m	v2@v2.3.1/normal_tx_pool.go:533	GetTxsByTxIds, want:1, get:1, time:[0ms]
2023-03-08 17:15:16.356	[WARN]	[Core] [31;1m@chain1[0m	common/tx_helper.go:438	verify tx result failed, block height:162, err:tx result (tx:174a66dc1675e905ca88e298bad140b33403439a4bd84c3987f5cc2e4318a5ab) expect 0804121f08011a1b636f6e747261637420696e697469616c206661696c2c204661696c1a20dc0fceb19c9345291a03ddfe7d1d0566fe69ae165b62875f559e558b4a45924c, got 0804122508011a21636f6e747261637420696e697469616c206661696c2c2074782074696d656f75741a20dc0fceb19c9345291a03ddfe7d1d0566fe69ae165b62875f559e558b4a45924c
Debug info:tx.Result:{"code":4,"contract_result":{"code":1,"message":"contract initial fail, Fail"},"rw_set_hash":"3A/OsZyTRSkaA93+fR0FZv5prhZbYodfVZ5Vi0pFkkw="}
current result:
{"code":4,"contract_result":{"code":1,"message":"contract initial fail, tx timeout"},"rw_set_hash":"3A/OsZyTRSkaA93+fR0FZv5prhZbYodfVZ5Vi0pFkkw="}
2023-03-08 17:15:16.356	[WARN]	[Core] [31;1m@chain1[0m	common/tx_helper.go:456	Block rw set verify fail txs
2023-03-08 17:15:16.356	[ERROR]	[Core] [31;1m@chain1[0m	common/tx_helper.go:310	verify tx failed, block height:162, err:Block rw set verify fail txs
2023-03-08 17:15:16.356	[ERROR]	[Core] [31;1m@chain1[0m	common/tx_helper.go:317	verify tx failed, block height:162, rw set verify failed tx ids:[174a66dc1675e905ca88e298bad140b33403439a4bd84c3987f5cc2e4318a5ab], err:Block rw set verify fail txs
2023-03-08 17:15:16.356	[WARN]	[Core] [31;1m@chain1[0m	verifier/block_verifier_impl.go:180	verify failed [162](9fd858baa5612e58a33316873174c8173ad2ea6e2c411013bd9991353410a7bd),preBlockHash:12fc2d2a61c9b30f4cc69fe21076216715bd8e28aeb04ccb0dac9cf665243e7c, verify failed [162](9fd858baa5612e58a33316873174c8173ad2ea6e2c411013bd9991353410a7bd), Block rw set verify fail txs 
2023-03-08 17:15:16.358	[INFO]	[Consensus] [31;1m@chain1[0m	v2@v2.3.2/consensus_tbft_impl.go:822	[QmQPN36BtUHqJUSr1oihopZa25i5ZZeJH5FKyaX9XPs1RQ](162/62/PROPOSE) receive verify result (162/9fd858baa5612e58a33316873174c8173ad2ea6e2c411013bd9991353410a7bd) FAIL
2023-03-08 17:15:16.358	[WARN]	[Consensus] [31;1m@chain1[0m	v2@v2.3.2/consensus_tbft_impl.go:837	[QmQPN36BtUHqJUSr1oihopZa25i5ZZeJH5FKyaX9XPs1RQ](162/62/PROPOSE) 9fd858baa5612e58a33316873174c8173ad2ea6e2c411013bd9991353410a7bd receive verify result (162/9fd858baa5612e58a33316873174c8173ad2ea6e2c411013bd9991353410a7bd) FAIL failed
2023-03-08 17:15:16.358	[INFO]	[Consensus] [31;1m@chain1[0m	v2@v2.3.2/consensus_tbft_impl.go:846	handleVerifyResult failed , invalidTx = [174a66dc1675e905ca88e298bad140b33403439a4bd84c3987f5cc2e4318a5ab]
2023-03-08 17:15:16.358	[INFO]	[Consensus] [31;1m@chain1[0m	v2@v2.3.2/consensus_tbft_impl.go:1808	[QmQPN36BtUHqJUSr1oihopZa25i5ZZeJH5FKyaX9XPs1RQ](162/62/PROPOSE) enter prevote (162/62)
2023-03-08 17:15:16.358	[INFO]	[Consensus] [31;1m@chain1[0m	v2@v2.3.2/consensus_tbft_impl.go:371	[QmQPN36BtUHqJUSr1oihopZa25i5ZZeJH5FKyaX9XPs1RQ](162/62/PREVOTE) sendProposeState isProposer: false
2023-03-08 17:15:16.358	[INFO]	[Consensus] [31;1m@chain1[0m	v2@v2.3.2/consensus_tbft_impl.go:1866	[QmQPN36BtUHqJUSr1oihopZa25i5ZZeJH5FKyaX9XPs1RQ](162/62/PREVOTE) generated prevote (162/62/4e696c48617368), time[sign:0ms]
2023-03-08 17:15:16.358	[INFO]	[Consensus] [31;1m@chain1[0m	v2@v2.3.2/consensus_tbft_impl.go:1122	[QmQPN36BtUHqJUSr1oihopZa25i5ZZeJH5FKyaX9XPs1RQ](162/62/PREVOTE) receive prevote QmQPN36BtUHqJUSr1oihopZa25i5ZZeJH5FKyaX9XPs1RQ(162/62/4e696c48617368), time[verify:0ms]
2023-03-08 17:15:16.358	[INFO]	[Consensus] [31;1m@chain1[0m	v2@v2.3.2/consensus_tbft_impl.go:1454	[QmQPN36BtUHqJUSr1oihopZa25i5ZZeJH5FKyaX9XPs1RQ](162/62/PREVOTE) prevoteQC (162/62/9fd858baa5612e58a33316873174c8173ad2ea6e2c411013bd9991353410a7bd)
2023-03-08 17:15:16.358	[INFO]	[Consensus] [31;1m@chain1[0m	v2@v2.3.2/consensus_tbft_impl.go:1484	[QmQPN36BtUHqJUSr1oihopZa25i5ZZeJH5FKyaX9XPs1RQ](162/62/PREVOTE) add vote failed, receive valid block: 9fd858baa5612e58a33316873174c8173ad2ea6e2c411013bd9991353410a7bd, but proposal is nil
2023-03-08 17:15:16.358	[INFO]	[Consensus] [31;1m@chain1[0m	v2@v2.3.2/consensus_tbft_impl.go:1883	[QmQPN36BtUHqJUSr1oihopZa25i5ZZeJH5FKyaX9XPs1RQ](162/62/PREVOTE) enter precommit (162/62)
2023-03-08 17:15:16.358	[INFO]	[Consensus] [31;1m@chain1[0m	v2@v2.3.2/consensus_tbft_impl.go:1966	[QmQPN36BtUHqJUSr1oihopZa25i5ZZeJH5FKyaX9XPs1RQ](162/62/PRECOMMIT) generated precommit (162/62/4e696c48617368), time[sign:0ms]
2023-03-08 17:15:16.358	[INFO]	[Consensus] [31;1m@chain1[0m	v2@v2.3.2/consensus_msg.go:73	QmQPN36BtUHqJUSr1oihopZa25i5ZZeJH5FKyaX9XPs1RQ send consensus voter:"QmQPN36BtUHqJUSr1oihopZa25i5ZZeJH5FKyaX9XPs1RQ" height:162 round:62 hash:"NilHash" endorsement:<signer:<member_type:PUBLIC_KEY member_info:"-----BEGIN PUBLIC KEY-----\nMFkwEwYHKoZIzj0CAQYIKoZIzj0DAQcDQgAE0kehblvTwgSY7/dHu6VPzAvEcoZi\nXA5Aj+S9OVm8FQL5ILFbnyOIKSLa4QEEMaNdkMbADjlWGSlCr9Z/e/TEEA==\n-----END PUBLIC KEY-----\n" > signature:"0D\002 a\262\310\254\203P\262\325\\\240\0344\367\0314\262\255J/\265\017\236\\M\244\3720\215\344S\315\323\002 J+\034\353\253\277\\\352\3309h-\316\362&\017\326\010\250\223i\267U\026\241\375r\234M\316E$" > invalidTxs:"174a66dc1675e905ca88e298bad140b33403439a4bd84c3987f5cc2e4318a5ab" 
2023-03-08 17:15:16.358	[INFO]	[Consensus] [31;1m@chain1[0m	v2@v2.3.2/consensus_msg.go:29	QmQPN36BtUHqJUSr1oihopZa25i5ZZeJH5FKyaX9XPs1RQ ready send consensus message to [QmQPN36BtUHqJUSr1oihopZa25i5ZZeJH5FKyaX9XPs1RQ QmV3BQgXAeWM68XCqCxhMNnvvvNYMdKaJZXcAEFfMDxd5G QmYBidYZM7AtQzanxhprenToZvEUTK99kUEYfC9W9q5yRH QmbfRmCpht135LTWkHXE4UWKVknMGLfsLaNs4pXm2CLfkz] 
2023-03-08 17:15:16.358	[INFO]	[Consensus] [31;1m@chain1[0m	v2@v2.3.2/consensus_tbft_impl.go:1174	[QmQPN36BtUHqJUSr1oihopZa25i5ZZeJH5FKyaX9XPs1RQ](162/62/PRECOMMIT) receive precommit QmQPN36BtUHqJUSr1oihopZa25i5ZZeJH5FKyaX9XPs1RQ(162/62/4e696c48617368), time[verify:0ms]
2023-03-08 17:15:16.358	[INFO]	[Consensus] [31;1m@chain1[0m	v2@v2.3.2/consensus_tbft_impl.go:1537	[QmQPN36BtUHqJUSr1oihopZa25i5ZZeJH5FKyaX9XPs1RQ](162/62/PRECOMMIT) precommitQC (162/62/9fd858baa5612e58a33316873174c8173ad2ea6e2c411013bd9991353410a7bd)
2023-03-08 17:15:16.358	[INFO]	[Consensus] [31;1m@chain1[0m	v2@v2.3.2/consensus_msg.go:41	QmQPN36BtUHqJUSr1oihopZa25i5ZZeJH5FKyaX9XPs1RQ send consensus message to QmYBidYZM7AtQzanxhprenToZvEUTK99kUEYfC9W9q5yRH succeeded
2023-03-08 17:15:16.358	[INFO]	[Consensus] [31;1m@chain1[0m	v2@v2.3.2/consensus_msg.go:41	QmQPN36BtUHqJUSr1oihopZa25i5ZZeJH5FKyaX9XPs1RQ send consensus message to QmbfRmCpht135LTWkHXE4UWKVknMGLfsLaNs4pXm2CLfkz succeeded
2023-03-08 17:15:16.358	[WARN]	[Consensus] [31;1m@chain1[0m	v2@v2.3.2/consensus_tbft_impl.go:1552	[QmQPN36BtUHqJUSr1oihopZa25i5ZZeJH5FKyaX9XPs1RQ](162/62/PRECOMMIT) receive valid block: 9fd858baa5612e58a33316873174c8173ad2ea6e2c411013bd9991353410a7bd, but proposal is nil
2023-03-08 17:15:16.358	[INFO]	[Consensus] [31;1m@chain1[0m	v2@v2.3.2/consensus_tbft_impl.go:1982	[QmQPN36BtUHqJUSr1oihopZa25i5ZZeJH5FKyaX9XPs1RQ](162/62/PRECOMMIT) enter commit (162/62)
2023-03-08 17:15:16.358	[INFO]	[Consensus] [31;1m@chain1[0m	v2@v2.3.2/consensus_tbft_impl.go:1988	[QmQPN36BtUHqJUSr1oihopZa25i5ZZeJH5FKyaX9XPs1RQ] consensus cost: {"Height":162,"EnterNewHeightTime":"2023-03-08 16:12:28.178047831 +0800 CST m=+598366.819522747","Rounds":{"62":{"Round":62,"Proposal":"16.977744464s","Prevote":"204.391µs","Precommit":"305.355µs","PersistStateDurations":{}}}}
2023-03-08 17:15:16.358	[INFO]	[Consensus] [31;1m@chain1[0m	v2@v2.3.2/consensus_tbft_impl.go:1616	[QmQPN36BtUHqJUSr1oihopZa25i5ZZeJH5FKyaX9XPs1RQ] attempt enterNewRound to (162/63)
2023-03-08 17:15:16.358	[INFO]	[Consensus] [31;1m@chain1[0m	v2@v2.3.2/consensus_tbft_impl.go:2069	[QmQPN36BtUHqJUSr1oihopZa25i5ZZeJH5FKyaX9XPs1RQ](162/62/COMMIT) getLastBlockProposer , proposerId[QmYBidYZM7AtQzanxhprenToZvEUTK99kUEYfC9W9q5yRH]
2023-03-08 17:15:16.358	[INFO]	[Consensus] [31;1m@chain1[0m	v2@v2.3.2/consensus_tbft_impl.go:1648	[QmQPN36BtUHqJUSr1oihopZa25i5ZZeJH5FKyaX9XPs1RQ] attempt enterPropose to (162/63)
2023-03-08 17:15:16.358	[INFO]	[Consensus] [31;1m@chain1[0m	v2@v2.3.2/consensus_msg.go:73	QmQPN36BtUHqJUSr1oihopZa25i5ZZeJH5FKyaX9XPs1RQ send consensus type:VOTE_PRECOMMIT voter:"QmQPN36BtUHqJUSr1oihopZa25i5ZZeJH5FKyaX9XPs1RQ" height:162 round:62 hash:"NilHash" endorsement:<signer:<member_type:PUBLIC_KEY member_info:"-----BEGIN PUBLIC KEY-----\nMFkwEwYHKoZIzj0CAQYIKoZIzj0DAQcDQgAE0kehblvTwgSY7/dHu6VPzAvEcoZi\nXA5Aj+S9OVm8FQL5ILFbnyOIKSLa4QEEMaNdkMbADjlWGSlCr9Z/e/TEEA==\n-----END PUBLIC KEY-----\n" > signature:"0F\002!\000\373\036\266\232b\324qb\007)\005\233&Q\314\317E\203\300\272@\331\207\023\262\366\353q\t\247\305X\002!\000\256H\3501\3003&#\t\316[;\246\000I0S1\265\350\215\265\272\276\313*\210t\230!O\210" > 
2023-03-08 17:15:16.358	[INFO]	[Consensus] [31;1m@chain1[0m	v2@v2.3.2/consensus_msg.go:29	QmQPN36BtUHqJUSr1oihopZa25i5ZZeJH5FKyaX9XPs1RQ ready send consensus message to [QmQPN36BtUHqJUSr1oihopZa25i5ZZeJH5FKyaX9XPs1RQ QmV3BQgXAeWM68XCqCxhMNnvvvNYMdKaJZXcAEFfMDxd5G QmYBidYZM7AtQzanxhprenToZvEUTK99kUEYfC9W9q5yRH QmbfRmCpht135LTWkHXE4UWKVknMGLfsLaNs4pXm2CLfkz] 
2023-03-08 17:15:16.358	[INFO]	[Consensus] [31;1m@chain1[0m	v2@v2.3.2/consensus_msg.go:41	QmQPN36BtUHqJUSr1oihopZa25i5ZZeJH5FKyaX9XPs1RQ send consensus message to QmbfRmCpht135LTWkHXE4UWKVknMGLfsLaNs4pXm2CLfkz succeeded
2023-03-08 17:15:16.358	[INFO]	[Consensus] [31;1m@chain1[0m	v2@v2.3.2/consensus_msg.go:41	QmQPN36BtUHqJUSr1oihopZa25i5ZZeJH5FKyaX9XPs1RQ send consensus message to QmV3BQgXAeWM68XCqCxhMNnvvvNYMdKaJZXcAEFfMDxd5G succeeded
2023-03-08 17:15:16.359	[INFO]	[Consensus] [31;1m@chain1[0m	v2@v2.3.2/consensus_msg.go:41	QmQPN36BtUHqJUSr1oihopZa25i5ZZeJH5FKyaX9XPs1RQ send consensus message to QmYBidYZM7AtQzanxhprenToZvEUTK99kUEYfC9W9q5yRH succeeded
2023-03-08 17:15:16.359	[INFO]	[Consensus] [31;1m@chain1[0m	v2@v2.3.2/consensus_msg.go:41	QmQPN36BtUHqJUSr1oihopZa25i5ZZeJH5FKyaX9XPs1RQ send consensus message to QmV3BQgXAeWM68XCqCxhMNnvvvNYMdKaJZXcAEFfMDxd5G succeeded
2023-03-08 17:15:16.360	[ERROR]	[Storage] [31;1m@chain1[0m	v2@v2.3.0/logger.go:191	Ignored key without a value.	{"ignored": "a085fdde81c205c3b3cf0cccd3ccd88957d39e23428971ecd067ac91bcbfe646"}
2023-03-08 17:15:16.356	[WARN]	[Storage] [31;1m@chain1[0m	statesqldb/statesqldb.go:812	rollback db transaction:
2023-03-08 17:15:16.363	[WARN]	[Storage] [31;1m@chain1[0m	v2@v2.3.2/sqldbtx.go:267	rollback tx[a085fdde81c205c3b3cf0cccd3ccd88957d39e23428971ecd067ac91bcbfe646], tx duration:9.355861742s
2023-03-08 17:15:16.374	[INFO]	[Storage] [31;1m@chain1[0m	statesqldb/statesqldb.go:651	create new sql db handle[0xc0001564d0] database[pknode4_statedb_chain1] for contract[]
2023-03-08 17:15:16.375	[WARN]	[Storage] [31;1m@chain1[0m	v2@v2.3.2/rawsqlprovider.go:426	Error 1146: Table 'pknode4_statedb_chain1.state_record_sql' doesn't exist
2023-03-08 17:15:16.376	[WARN]	[Storage] [31;1m@chain1[0m	v2@v2.3.2/rawsqlprovider.go:352	Error 1146: Table 'pknode4_statedb_chain1.state_record_sql' doesn't exist
2023-03-08 17:15:16.376	[WARN]	[Storage] [31;1m@chain1[0m	statesqldb/statesqldb.go:752	DDLRecord[DROP DATABASE pknode4_statedb_chain1_aaaaa] save fail. error: sql error
2023-03-08 17:15:16.376	[WARN]	[Storage] [31;1m@chain1[0m	v2@v2.3.2/rawsqlprovider.go:352	Error 1008: Can't drop database 'pknode4_statedb_chain1_aaaaa'; database doesn't exist
2023-03-08 17:15:16.376	[WARN]	[Storage] [31;1m@chain1[0m	v2@v2.3.2/rawsqlprovider.go:352	Error 1146: Table 'pknode4_statedb_chain1.state_record_sql' doesn't exist
2023-03-08 17:15:16.376	[WARN]	[Storage] [31;1m@chain1[0m	statesqldb/statesqldb.go:762	DDLRecord[DROP DATABASE pknode4_statedb_chain1_aaaaa] update fail. error: sql error
2023-03-08 17:15:16.376	[ERROR]	[Core] [31;1m@chain1[0m	verifier/block_verifier_impl.go:192	block [162] rollback sql failed: sql error
2023-03-08 17:15:16.376	[INFO]	[Snapshot] [31;1m@chain1[0m	snapshot/snapshot_manager.go:141	clear snapshot@chain1 at height 162
2023-03-08 17:15:16.376	[INFO]	[Snapshot] [31;1m@chain1[0m	snapshot/snapshot_manager.go:155	delete snapshot@chain1 bf833c2167754d7888f44de3c99ef4a7cb7b960d595f4ae7fcedc083acdee258 at height 162

在此之后,该节点便无法同步数据。

我将data文件夹和node4相关数据库都删除后,再次启动该节点,仍然无法同步数据,区块1都同步不了。

2023-03-10 10:37:14.613	[INFO]	[Sync] @chain1	sync/scheduler.go:289	request block[height: 120] from node [QmbfRmCpht135LTWkHXE4UWKVknMGLfsLaNs4pXm2CLfkz], BatchesSizeInReq: 1
2023-03-10 10:37:14.632	[INFO]	[Sync] @chain1	sync/scheduler.go:289	request block[height: 121] from node [QmbfRmCpht135LTWkHXE4UWKVknMGLfsLaNs4pXm2CLfkz], BatchesSizeInReq: 1
2023-03-10 10:37:14.652	[INFO]	[Sync] @chain1	sync/scheduler.go:289	request block[height: 122] from node [QmbfRmCpht135LTWkHXE4UWKVknMGLfsLaNs4pXm2CLfkz], BatchesSizeInReq: 1
2023-03-10 10:37:14.672	[INFO]	[Sync] @chain1	sync/scheduler.go:289	request block[height: 123] from node [QmbfRmCpht135LTWkHXE4UWKVknMGLfsLaNs4pXm2CLfkz], BatchesSizeInReq: 1
2023-03-10 10:37:14.692	[INFO]	[Sync] @chain1	sync/scheduler.go:289	request block[height: 124] from node [QmbfRmCpht135LTWkHXE4UWKVknMGLfsLaNs4pXm2CLfkz], BatchesSizeInReq: 1
2023-03-10 10:37:14.713	[INFO]	[Sync] @chain1	sync/scheduler.go:289	request block[height: 125] from node [QmbfRmCpht135LTWkHXE4UWKVknMGLfsLaNs4pXm2CLfkz], BatchesSizeInReq: 1
2023-03-10 10:37:14.732	[INFO]	[Sync] @chain1	sync/scheduler.go:289	request block[height: 126] from node [QmbfRmCpht135LTWkHXE4UWKVknMGLfsLaNs4pXm2CLfkz], BatchesSizeInReq: 1
2023-03-10 10:37:14.752	[INFO]	[Sync] @chain1	sync/scheduler.go:289	request block[height: 127] from node [QmbfRmCpht135LTWkHXE4UWKVknMGLfsLaNs4pXm2CLfkz], BatchesSizeInReq: 1
2023-03-10 10:37:14.772	[INFO]	[Sync] @chain1	sync/scheduler.go:289	request block[height: 128] from node [QmbfRmCpht135LTWkHXE4UWKVknMGLfsLaNs4pXm2CLfkz], BatchesSizeInReq: 1
2023-03-10 10:37:17.203	[INFO]	[Net]	libp2pnet/libp2p_connection_supervisor.go:116	[ConnSupervisor] all necessary peers connected.
2023-03-10 10:37:43.232	[INFO]	[Sync] @chain1	sync/scheduler.go:289	request block[height: 1] from node [QmbfRmCpht135LTWkHXE4UWKVknMGLfsLaNs4pXm2CLfkz], BatchesSizeInReq: 1
2023-03-10 10:38:14.232	[INFO]	[Sync] @chain1	sync/scheduler.go:289	request block[height: 1] from node [QmbfRmCpht135LTWkHXE4UWKVknMGLfsLaNs4pXm2CLfkz], BatchesSizeInReq: 1
2023-03-10 10:38:45.212	[INFO]	[Sync] @chain1	sync/scheduler.go:289	request block[height: 1] from node [QmV3BQgXAeWM68XCqCxhMNnvvvNYMdKaJZXcAEFfMDxd5G], BatchesSizeInReq: 1
2023-03-10 10:39:12.204	[INFO]	[Net]	libp2pnet/libp2p_net.go:887	[Net] add peer to chain pub-sub white list, (pid: QmQPN36BtUHqJUSr1oihopZa25i5ZZeJH5FKyaX9XPs1RQ, chain id: chain1)
2023-03-10 10:39:12.204	[INFO]	[Net]	libp2pnet/libp2p_net.go:887	[Net] add peer to chain pub-sub white list, (pid: QmYBidYZM7AtQzanxhprenToZvEUTK99kUEYfC9W9q5yRH, chain id: chain1)
2023-03-10 10:39:12.204	[INFO]	[Net]	libp2pnet/libp2p_net.go:887	[Net] add peer to chain pub-sub white list, (pid: QmV3BQgXAeWM68XCqCxhMNnvvvNYMdKaJZXcAEFfMDxd5G, chain id: chain1)
2023-03-10 10:39:12.204	[INFO]	[Net]	libp2pnet/libp2p_net.go:887	[Net] add peer to chain pub-sub white list, (pid: QmbfRmCpht135LTWkHXE4UWKVknMGLfsLaNs4pXm2CLfkz, chain id: chain1)
2023-03-10 10:39:15.232	[INFO]	[Sync] @chain1	sync/scheduler.go:289	request block[height: 1] from node [QmbfRmCpht135LTWkHXE4UWKVknMGLfsLaNs4pXm2CLfkz], BatchesSizeInReq: 1
2023-03-10 10:39:46.232	[INFO]	[Sync] @chain1	sync/scheduler.go:289	request block[height: 1] from node [QmbfRmCpht135LTWkHXE4UWKVknMGLfsLaNs4pXm2CLfkz], BatchesSizeInReq: 1
2023-03-10 10:40:17.212	[INFO]	[Sync] @chain1	sync/scheduler.go:289	request block[height: 1] from node [QmV3BQgXAeWM68XCqCxhMNnvvvNYMdKaJZXcAEFfMDxd5G], BatchesSizeInReq: 1

【相关日志文件】(如果有报错日志请贴图,或者上传附件)

chainmaker-go 的 log/system.log & bin/panic.log file *

SDK 的 sdk.log file

  • node4日志 system.2023030817.log
  • 其他节点日志参考 system-node2.log system-node1-17.log
  • 重新启动后,节点debug日志 system.310.log
  • 重启后,节点1的日志,重启时间在12:06附近 system.node1-1200.log

【系统信息】(请填写系统信息,方便定位问题)

  • 版本:2.3.1
  • 模式:pk模式
  • 数据库:mysql
  • 系统环境:Ubuntu 9.4.0
  • 链情况:在一个4节点的链中,节点名分别为:node1,node2,node3,node4
Edited Mar 10, 2023 by sen zhang
To upload designs, you'll need to enable LFS and have an admin enable hashed storage. More information
Assignee
Assign to
None
Milestone
None
Assign milestone
Time tracking
None
Due date
None
Reference: chainmaker/issue#577

Copyright © 2021 ChainMaker Org. All Rights Reserved. 长安链 版权所有。