2025-11-10T03:07:32.206Z DEBUG chain/entity.go:440 process block, no block in buffer {"current round": 220372} 2025-11-10T03:07:32.196Z DEBUG miner/protocol_round.go:1028 verify block - pending {"round": 220372, "block": "119887138411bbfa9f3f20eca53b801485b12ad90d3b4163160685973c6607d8"} 2025-11-10T03:07:32.196Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 220372, "randk": 0, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T03:07:32.196Z DEBUG miner/protocol_receive.go:130 verify block processed {"round": 220372, "block": "119887138411bbfa9f3f20eca53b801485b12ad90d3b4163160685973c6607d8"} 2025-11-10T03:07:32.196Z DEBUG miner/protocol_round.go:759 update prev block notarization, already notarized {"round": 220371, "block": "906223b5bbf90cbc691f071137c13311ebc34a148b6711815536d03bc7c5ca95"} 2025-11-10T03:07:32.196Z DEBUG miner/round.go:143 Adding block to verifyChannel {"round": 220372, "block hash": "119887138411bbfa9f3f20eca53b801485b12ad90d3b4163160685973c6607d8", "magic block": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "magic block round": 0} 2025-11-10T03:07:32.196Z INFO miner/protocol_round.go:803 adding block to verify {"round": 220372, "block": "119887138411bbfa9f3f20eca53b801485b12ad90d3b4163160685973c6607d8", "prev_block": "906223b5bbf90cbc691f071137c13311ebc34a148b6711815536d03bc7c5ca95", "state_hash": "e29c9bd7e3aef0a445593a6a7645bf74412410c48fbe5c289c30d4351294bbf8", "weight": 1} 2025-11-10T03:07:32.196Z INFO miner/protocol_round.go:613 handle verify block - added block for ticket verification {"round": 220372, "block": "119887138411bbfa9f3f20eca53b801485b12ad90d3b4163160685973c6607d8", "magic block": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "magic block round": 0} 2025-11-10T03:07:32.196Z INFO chain/protocol_block.go:225 not reached notarization {"mb_sr": 0, "active_miners": 3, "threshold": 2, "num_signatures": 0, "current_round": 220372, "round": 220372} 2025-11-10T03:07:32.196Z DEBUG miner/protocol_round.go:1028 verify block - pending {"round": 220372, "block": "3bdfe5a08cc18e310eb7a248e419ca0c7642a038d449940f04994bedc7e9c024"} 2025-11-10T03:07:32.196Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 220372, "randk": 1, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T03:07:32.196Z DEBUG miner/protocol_round.go:759 update prev block notarization, already notarized {"round": 220371, "block": "906223b5bbf90cbc691f071137c13311ebc34a148b6711815536d03bc7c5ca95"} 2025-11-10T03:07:32.196Z DEBUG miner/protocol_receive.go:130 verify block processed {"round": 220372, "block": "3bdfe5a08cc18e310eb7a248e419ca0c7642a038d449940f04994bedc7e9c024"} 2025-11-10T03:07:32.196Z DEBUG miner/round.go:143 Adding block to verifyChannel {"round": 220372, "block hash": "3bdfe5a08cc18e310eb7a248e419ca0c7642a038d449940f04994bedc7e9c024", "magic block": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "magic block round": 0} 2025-11-10T03:07:32.196Z INFO miner/protocol_round.go:803 adding block to verify {"round": 220372, "block": "3bdfe5a08cc18e310eb7a248e419ca0c7642a038d449940f04994bedc7e9c024", "prev_block": "906223b5bbf90cbc691f071137c13311ebc34a148b6711815536d03bc7c5ca95", "state_hash": "46b01d415c1577d695a108afa33b70a409c12a52792f5a6febddc009250495d4", "weight": 1} 2025-11-10T03:07:32.196Z INFO miner/protocol_round.go:613 handle verify block - added block for ticket verification {"round": 220372, "block": "3bdfe5a08cc18e310eb7a248e419ca0c7642a038d449940f04994bedc7e9c024", "magic block": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "magic block round": 0} 2025-11-10T03:07:32.196Z INFO chain/protocol_block.go:225 not reached notarization {"mb_sr": 0, "active_miners": 3, "threshold": 2, "num_signatures": 0, "current_round": 220372, "round": 220372} 2025-11-10T03:07:32.195Z DEBUG miner/protocol_receive.go:169 verify block {"round": 220372, "block": "119887138411bbfa9f3f20eca53b801485b12ad90d3b4163160685973c6607d8"} 2025-11-10T03:07:32.195Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"verify_block","value":"Verify Block"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "duration": "36.63µs"} 2025-11-10T03:07:32.195Z DEBUG miner/worker.go:53 message {"msg": {"code":"verify_block","value":"Verify Block"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71"} 2025-11-10T03:07:32.195Z DEBUG miner/protocol_receive.go:169 verify block {"round": 220372, "block": "3bdfe5a08cc18e310eb7a248e419ca0c7642a038d449940f04994bedc7e9c024"} 2025-11-10T03:07:32.195Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"verify_block","value":"Verify Block"}, "sender_index": 2, "id": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "duration": "59.93µs"} 2025-11-10T03:07:32.195Z DEBUG miner/worker.go:53 message {"msg": {"code":"verify_block","value":"Verify Block"}, "sender_index": 2, "id": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea"} 2025-11-10T03:07:32.177Z INFO miner/m_handler.go:242 Reject VRFShare: VRF is complete for this round {"vrfs_round_num": 220372, "vrfs_sender_index": 0, "vrfs_round_num": 220372} 2025-11-10T03:07:32.177Z INFO miner/m_handler.go:242 Reject VRFShare: VRF is complete for this round {"vrfs_round_num": 220372, "vrfs_sender_index": 0, "vrfs_round_num": 220372} 2025-11-10T03:07:32.177Z DEBUG transaction/worker.go:253 [mvc] see no old txns {"clientID": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "nonce": 112404} 2025-11-10T03:07:32.177Z INFO memorystore/collection.go:65 Redis returned 0 rows after seclect 2025-11-10T03:07:32.177Z DEBUG transaction/worker.go:221 [mvc] remove old nonce txns {"clientID": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "nonce": 112404} 2025-11-10T03:07:32.177Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "-B\ufffd{\ufffdD\ufffdL\ufffd\ufffd\ufffd\ufffd\ufffd\u0011\u0006V\ufffd\u0008\u0011\ufffd+\ufffd\ufffd35\ufffd\u0019\ufffdL\ufffd+\ufffd"} 2025-11-10T03:07:32.176Z INFO transaction/worker.go:164 cleaning transactions {"collection": "collection.txn:0afc093ffb509f059c55478bc1a60351cef7b4e9c008a53a6cc8241ca8617dfe", "missing_count": 2, "txns": ["3706b5aece9d73838045a9d1b43de9b6ecf18f4c2bed9c8884ecdf90d6f1310b", "7725506ebb969276623bb2bd17b2fdb7dcf8c2e76ea1f12533a77d56b964f378"], "past txns": []} 2025-11-10T03:07:32.176Z INFO memorystore/collection.go:65 Redis returned 0 rows after seclect 2025-11-10T03:07:32.176Z INFO chain/entity.go:1721 delete blocks below round {"round": 220372, "below_round": 220318, "before": 1762743992, "total": 313, "count": 5} 2025-11-10T03:07:32.176Z DEBUG chain/entity.go:1714 found block to delete {"round": 220318, "block_round": 220074, "current_round": 220372, "lf_round": 220368} 2025-11-10T03:07:32.176Z DEBUG chain/entity.go:1714 found block to delete {"round": 220318, "block_round": 220075, "current_round": 220372, "lf_round": 220368} 2025-11-10T03:07:32.176Z DEBUG transaction/worker.go:124 cleaning past transactions 2025-11-10T03:07:32.176Z DEBUG chain/entity.go:1714 found block to delete {"round": 220318, "block_round": 220073, "current_round": 220372, "lf_round": 220368} 2025-11-10T03:07:32.176Z DEBUG miner/round.go:238 Round clear - cancel verification 2025-11-10T03:07:32.176Z DEBUG chain/entity.go:1714 found block to delete {"round": 220318, "block_round": 220076, "current_round": 220372, "lf_round": 220368} 2025-11-10T03:07:32.176Z DEBUG chain/entity.go:1714 found block to delete {"round": 220318, "block_round": 220072, "current_round": 220372, "lf_round": 220368} 2025-11-10T03:07:32.176Z DEBUG chain/protocol_round.go:334 finalize round - block has less than 3 confirmation 2025-11-10T03:07:32.176Z DEBUG chain/protocol_round.go:334 finalize round - block has less than 3 confirmation 2025-11-10T03:07:32.176Z INFO chain/protocol_round.go:402 finalize round - finalize block success {"round": 220368, "block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9", "duration": "4.957701ms"} 2025-11-10T03:07:32.176Z DEBUG chain/worker.go:230 finalize block processed {"round": 220368, "duration": "4.886971ms"} 2025-11-10T03:07:32.176Z DEBUG chain/protocol_block.go:612 finalized block - done {"round": 220368, "block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9", "duration": "4.492437ms"} 2025-11-10T03:07:32.176Z INFO chain/entity.go:2366 config has been updated successfully {"start of round": 220368} 2025-11-10T03:07:32.175Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\ufffd\u001e\ufffd-7cq\u000e\ufffd\ufffdz\ufffdz\ufffd\ufffd\u0012\ufffdD\u001b\ufffdlj罦\ufffd\ufffd\u0003\ufffd'\ufffd}"} 2025-11-10T03:07:32.175Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\ufffd1f\u000b\ufffd\ufffdq[\ufffd\ufffd\ufffd`)x\ufffd\ufffdw\ufffdj:\ufffdH\u0001\ufffd⩲\ufffd\ufffd\ufffd\ufffd\ufffd"} 2025-11-10T03:07:32.175Z DEBUG miner/chain.go:313 delete txns {"txns": ["3706b5aece9d73838045a9d1b43de9b6ecf18f4c2bed9c8884ecdf90d6f1310b", "7725506ebb969276623bb2bd17b2fdb7dcf8c2e76ea1f12533a77d56b964f378"]} 2025-11-10T03:07:32.175Z INFO miner/protocol_block.go:619 update finalized block (debug transaction) {"txn": "7725506ebb969276623bb2bd17b2fdb7dcf8c2e76ea1f12533a77d56b964f378", "block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9"} 2025-11-10T03:07:32.175Z INFO miner/protocol_block.go:619 update finalized block (debug transaction) {"txn": "3706b5aece9d73838045a9d1b43de9b6ecf18f4c2bed9c8884ecdf90d6f1310b", "block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9"} 2025-11-10T03:07:32.175Z DEBUG chain/lfb_round_node.go:33 [mvc] store lfb {"round": 220368, "block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9", "mb number": 1} 2025-11-10T03:07:32.175Z DEBUG chain/worker.go:443 BC is moving {"current_lfb_round": 220368, "last_round": 220367} 2025-11-10T03:07:32.175Z DEBUG chain/entity.go:2269 set lfb {"round": 220368, "block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9", "state_computed": true} 2025-11-10T03:07:32.175Z INFO miner/protocol_block.go:613 update finalized block {"round": 220368, "block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9", "lf_round": 220367, "current_round": 220372, "weight": 1} 2025-11-10T03:07:32.174Z DEBUG chain/state.go:128 finalize round - rebased current state db {"round": 220368, "block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9", "state hash": "5ea97bb785ede9d7c5768c8aae547ddce98afeb752aa443ed99f3916101dd605"} 2025-11-10T03:07:32.174Z DEBUG util/mpt_nodedb.go:556 LevelNodeDB rebase db 2025-11-10T03:07:32.174Z DEBUG chain/protocol_block.go:424 finalize block - record dead nodes {"round": 220368, "block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9", "num dead nodes": 15} 2025-11-10T03:07:32.174Z DEBUG chain/protocol_block.go:409 MPT state node stat - inc {"node num": -420990, "change num": 11, "delete num": 15} 2025-11-10T03:07:32.173Z INFO block/entity.go:1195 save state {"round": 220368, "block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9", "block_size": 2, "changes": 11, "client_state": "5ea97bb785ede9d7c5768c8aae547ddce98afeb752aa443ed99f3916101dd605", "duration": "1.799355ms"} 2025-11-10T03:07:32.173Z DEBUG util/merkle_patricia_trie.go:272 MPT save changes success {"duration": "1.313731ms"} 2025-11-10T03:07:32.173Z DEBUG util/mpt_node_change.go:156 MPT - update changes done {"changes": 11} 2025-11-10T03:07:32.173Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"vrf_share","value":"VRF Share"}, "sender_index": 2, "id": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "duration": "1.634993ms"} 2025-11-10T03:07:32.172Z INFO miner/protocol_round.go:830 Starting round verification {"round": 220372, "delta": "180ms"} 2025-11-10T03:07:32.172Z INFO round/entity.go:618 get miners by rank {"num_miners": 3, "round": 220372, "r.minerPerm": [0, 2, 1]} 2025-11-10T03:07:32.172Z INFO miner/protocol_round.go:322 TOC_FIX Not a generator {"round": 220372, "index": 1, "rank": 2, "timeout_count": 0, "random_seed": -8911451846688350236} 2025-11-10T03:07:32.172Z INFO miner/protocol_bls.go:591 Starting round with vrf {"round": 220372, "roundtimeout": 0, "rseed": -8911451846688350236, "prev_round": 220371, "Prev_rseed": 0} 2025-11-10T03:07:32.172Z DEBUG miner/protocol_bls.go:542 DKG computeRBO {"round": 220372} 2025-11-10T03:07:32.172Z INFO miner/protocol_bls.go:524 receive bls sign {"round": 220372, "group_signature": "1 1d3e065e2f4e40cb137401cfd03ffbfdc0f079b7bd8912298da27347af092ef3 192ea60c077bb5ae8a05d7d41386181b533a9b5936e22e3cd905a2b466fad287", "rboOutput": "845429c2a5245fe4b6a7fe106a7e2f7eb02ff8705ca4d78e4ace26b8c1e8d95d", "dkg_starting_round": 0, "dkg_mb_number": 1} 2025-11-10T03:07:32.172Z DEBUG miner/protocol_bls.go:496 VRF Hurray we've threshold BLS shares {"round": 220372, "round pointer": "0xc00c9f2750"} 2025-11-10T03:07:32.172Z DEBUG round/entity.go:684 add_vrf_share {"round": 220372, "round_vrf_num": 2, "threshold": 2} 2025-11-10T03:07:32.172Z INFO miner/protocol_bls.go:430 verified vrf {"round": 220372, "node_id": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "share": "1 1e00ca1c115812fdc9c7f3bb19542b2631ae6fa617783f4e9f08069efe1a68ff 166b7c12a841a13d4f8deaa50c5f1c8c4629e9a20d9e3c36eb62cfb5670d95f9", "from": "1c3227e496fdf3c9aa604f3470a2bbd1", "message": "220372067f999dee3290ef7"} 2025-11-10T03:07:32.172Z DEBUG util/mpt_node_change.go:150 MPT - update changes {"changes": 11} 2025-11-10T03:07:32.171Z DEBUG bls/dkg.go:396 dkg verify {"id": "1c3227e496fdf3c9aa604f3470a2bbd1", "key": "1 6603e20478fac2c72a61b85056977b92696b8fffd408d8acac0e1f47aed3f96 1501242ed9000d9c6a02764160261164a52360a692c34ed452ff097bc90ee9b3 7f8aaa178d31fa4cbd0c1974768dfa4921e29405754ebf8d2c163a774b741a2 24515e04bd685a5559260f5d1868e5ea11abaf21f55a56aee52c15d9f3c2b053", "msg": "220372067f999dee3290ef7", "sig": "1 1e00ca1c115812fdc9c7f3bb19542b2631ae6fa617783f4e9f08069efe1a68ff 166b7c12a841a13d4f8deaa50c5f1c8c4629e9a20d9e3c36eb62cfb5670d95f9"} 2025-11-10T03:07:32.171Z INFO round/entity.go:618 get miners by rank {"num_miners": 3, "round": 220368, "r.minerPerm": [1, 2, 0]} 2025-11-10T03:07:32.171Z INFO chain/protocol_block.go:363 finalize block -- round {"round": {"number":220368,"round_random_seed":738276690486779379,"block_hash":"25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9","vrf_output":"0a3ee2bd0a6a5df3ca1998846f6c4b2aa4cde575200aba92d259f93c2bd5aad6"}, "block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9"} 2025-11-10T03:07:32.171Z INFO chain/protocol_block.go:328 finalize block {"round": 220368, "current_round": 220372, "lf_round": 220367, "hash": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9", "round_rank": 0, "state": 7} 2025-11-10T03:07:32.171Z DEBUG chain/worker.go:262 start to finalize block {"round": 220368, "block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9", "prev block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e"} 2025-11-10T03:07:32.171Z INFO miner/protocol_bls.go:265 BLS sign VRF share calculated for {"round": 220372, "round_timeout": 0, "prev_rseed": 7492188637680439031, "prev round vrf random seed": "67f999dee3290ef7", "bls_msg": "220372067f999dee3290ef7"} 2025-11-10T03:07:32.171Z INFO miner/protocol_bls.go:364 DKG AddVRFShare {"round": 220372, "round_vrf_num": 1, "threshold": 2, "sender": 2, "round_timeout_count": 0, "vrf_timeout_count": 0, "vrf_share": "1 1e00ca1c115812fdc9c7f3bb19542b2631ae6fa617783f4e9f08069efe1a68ff 166b7c12a841a13d4f8deaa50c5f1c8c4629e9a20d9e3c36eb62cfb5670d95f9"} 2025-11-10T03:07:32.171Z DEBUG miner/protocol_receive.go:26 handle vrf share {"round": 220372, "vrf_timeout_count": 0, "sender_index": 2} 2025-11-10T03:07:32.171Z DEBUG miner/worker.go:53 message {"msg": {"code":"vrf_share","value":"VRF Share"}, "sender_index": 2, "id": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea"} 2025-11-10T03:07:32.171Z INFO chain/protocol_round.go:359 finalize round {"round": 220368, "lfb round": 220370, "block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9"} 2025-11-10T03:07:32.171Z INFO chain/protocol_round.go:326 finalize round - latest finalized round {"round": 220371, "lfb round": 220370, "lfb block": "a18000018bdf9d386bd0ae02adf0990c907c8e27191a4622e0444af4795b6e84"} 2025-11-10T03:07:32.168Z INFO chain/protocol_round.go:199 finalize round {"round": 220371, "plfb_round": 220367, "num_round_notarized": 1, "num_chain_notarized": 3} 2025-11-10T03:07:32.169Z INFO miner/protocol_bls.go:489 Not yet reached threshold {"vrfShares_num": 1, "threshold": 2, "round": 220372} 2025-11-10T03:07:32.169Z DEBUG round/entity.go:684 add_vrf_share {"round": 220372, "round_vrf_num": 1, "threshold": 2} 2025-11-10T03:07:32.169Z INFO miner/protocol_bls.go:430 verified vrf {"round": 220372, "node_id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "share": "1 1c4b98aa94bd7205ca740c0b623bb43be72bd5038e4e8dcdfd44ffa118efc255 27a8d6bc676a436d5556595706dc80fe415355b74d3b620e5523663f8c04442", "from": "196b96df7631e00d339f9a25131927c4", "message": "220372067f999dee3290ef7"} 2025-11-10T03:07:32.169Z DEBUG bls/dkg.go:396 dkg verify {"id": "196b96df7631e00d339f9a25131927c4", "key": "1 1f8c72cc3a6b74f6ad7528172b64afe3dc42ee1987495659fe2cf34e749caa7c 20957b4d25e7b5fb1e32d4e3b93e2b73dad7f118efb6dae28715e4ad627b0fff 14259a6ddf4b44c83c1389bd8ed1fc47c1b099c5986bb33923bbcbb25d30054a 2100bb7434dadde1a5ed8545748d0958955bcd21e06cf170f78dbda35a9e04b7", "msg": "220372067f999dee3290ef7", "sig": "1 1c4b98aa94bd7205ca740c0b623bb43be72bd5038e4e8dcdfd44ffa118efc255 27a8d6bc676a436d5556595706dc80fe415355b74d3b620e5523663f8c04442"} 2025-11-10T03:07:32.168Z INFO miner/protocol_bls.go:265 BLS sign VRF share calculated for {"round": 220372, "round_timeout": 0, "prev_rseed": 7492188637680439031, "prev round vrf random seed": "67f999dee3290ef7", "bls_msg": "220372067f999dee3290ef7"} 2025-11-10T03:07:32.168Z INFO miner/protocol_bls.go:364 DKG AddVRFShare {"round": 220372, "round_vrf_num": 0, "threshold": 2, "sender": 1, "round_timeout_count": 0, "vrf_timeout_count": 0, "vrf_share": "1 1c4b98aa94bd7205ca740c0b623bb43be72bd5038e4e8dcdfd44ffa118efc255 27a8d6bc676a436d5556595706dc80fe415355b74d3b620e5523663f8c04442"} 2025-11-10T03:07:32.168Z INFO miner/protocol_round.go:78 add_my_vrf_share {"round": 220372, "round_timeout": 0, "dkg_starting_round": 0, "dkg_mb_number": 1, "pr_seed": 7492188637680439031, "pr_vrf_seed": "67f999dee3290ef7", "share": "1 1c4b98aa94bd7205ca740c0b623bb43be72bd5038e4e8dcdfd44ffa118efc255 27a8d6bc676a436d5556595706dc80fe415355b74d3b620e5523663f8c04442"} 2025-11-10T03:07:32.168Z DEBUG miner/protocol_bls.go:305 get_bls_share {"round": 220372, "rtc": 0, "dkg_pi": "1 1f8c72cc3a6b74f6ad7528172b64afe3dc42ee1987495659fe2cf34e749caa7c 20957b4d25e7b5fb1e32d4e3b93e2b73dad7f118efb6dae28715e4ad627b0fff 14259a6ddf4b44c83c1389bd8ed1fc47c1b099c5986bb33923bbcbb25d30054a 2100bb7434dadde1a5ed8545748d0958955bcd21e06cf170f78dbda35a9e04b7", "dkg_sr": 0, "mb_sr": 0, "share": "1 1c4b98aa94bd7205ca740c0b623bb43be72bd5038e4e8dcdfd44ffa118efc255 27a8d6bc676a436d5556595706dc80fe415355b74d3b620e5523663f8c04442"} 2025-11-10T03:07:32.168Z DEBUG chain/protocol_round.go:160 finalize round {"round": 220371, "lf_round": 220367} 2025-11-10T03:07:32.168Z DEBUG bls/dkg.go:356 dkg sign {"key": "1ef4cd5ccbeb2dfce1247caae9b2222f43537288563d8624eeb7f5102005c109", "pi": "1 1f8c72cc3a6b74f6ad7528172b64afe3dc42ee1987495659fe2cf34e749caa7c 20957b4d25e7b5fb1e32d4e3b93e2b73dad7f118efb6dae28715e4ad627b0fff 14259a6ddf4b44c83c1389bd8ed1fc47c1b099c5986bb33923bbcbb25d30054a 2100bb7434dadde1a5ed8545748d0958955bcd21e06cf170f78dbda35a9e04b7"} 2025-11-10T03:07:32.168Z DEBUG miner/protocol_bls.go:293 Sign msg with dkg {"msg": "220372067f999dee3290ef7", "round": 220372, "dkg starting round": 0} 2025-11-10T03:07:32.168Z INFO miner/protocol_bls.go:265 BLS sign VRF share calculated for {"round": 220372, "round_timeout": 0, "prev_rseed": 7492188637680439031, "prev round vrf random seed": "67f999dee3290ef7", "bls_msg": "220372067f999dee3290ef7"} 2025-11-10T03:07:32.168Z INFO miner/protocol_bls.go:283 DKG getBlsShare {"Round Number": 220372} 2025-11-10T03:07:32.168Z INFO miner/protocol_round.go:244 StartNextRound - add VRF {"round": 220372} 2025-11-10T03:07:32.168Z INFO miner/round.go:40 Try to cancel block generation that have not been started yet {"round": 220371} 2025-11-10T03:07:32.167Z DEBUG miner/protocol_round.go:210 finalizedRound - cancel round verification {"round": 220371} 2025-11-10T03:07:32.167Z INFO chain/entity.go:2016 Moving to the next round {"next_round": 220372} 2025-11-10T03:07:32.167Z DEBUG miner/protocol_round.go:154 [wait not ahead] [2] not ahead, can move on {"round": 220371, "lfb tk round": 220367} 2025-11-10T03:07:32.166Z DEBUG miner/protocol_round.go:123 [wait not ahead] 2025-11-10T03:07:32.166Z DEBUG miner/protocol_round.go:991 verification_complete {"top_verified_rank": 0} 2025-11-10T03:07:32.166Z INFO miner/protocol_round.go:986 verification_complete {"round": 220371, "verified_blocks": 0} 2025-11-10T03:07:32.166Z DEBUG miner/protocol_round.go:943 verifyAndSend - finished successfully {"round": 220371, "block": "906223b5bbf90cbc691f071137c13311ebc34a148b6711815536d03bc7c5ca95"} 2025-11-10T03:07:32.166Z INFO miner/round.go:44 Cancelling block generation {"round": 220371} 2025-11-10T03:07:32.166Z INFO miner/round.go:230 Cancelling verification {"round": 220371} 2025-11-10T03:07:32.166Z INFO miner/protocol_receive.go:456 process notarization - start next round {"new round": 220372} 2025-11-10T03:07:32.166Z DEBUG miner/protocol_round.go:1149 check block notarization - block notarized {"round": 220371, "block": "906223b5bbf90cbc691f071137c13311ebc34a148b6711815536d03bc7c5ca95"} 2025-11-10T03:07:32.166Z DEBUG round/entity.go:344 reached notarization {"round": 220371} 2025-11-10T03:07:32.166Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 220371, "randk": 0, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T03:07:32.166Z INFO chain/entity.go:1571 Adding a notarized block for current round {"Round": 220371} 2025-11-10T03:07:32.166Z INFO chain/protocol_block.go:303 reached notarization - add tickets {"round": 220371, "current_round": 220371, "block": "906223b5bbf90cbc691f071137c13311ebc34a148b6711815536d03bc7c5ca95", "tickets_num": 2} 2025-11-10T03:07:32.166Z INFO miner/protocol_round.go:920 verifyAndSend - sending verification ticket {"round": 220371, "block": "906223b5bbf90cbc691f071137c13311ebc34a148b6711815536d03bc7c5ca95", "block_rank": 0, "RRS": 7492188637680439031} 2025-11-10T03:07:32.166Z INFO chain/protocol_block.go:319 reached notarization - merging tickets {"round": 220370, "current_round": 220371, "block": "a18000018bdf9d386bd0ae02adf0990c907c8e27191a4622e0444af4795b6e84", "tickets_num": 2} 2025-11-10T03:07:32.166Z DEBUG miner/protocol_round.go:1069 verify round block - finished verification {"block": "906223b5bbf90cbc691f071137c13311ebc34a148b6711815536d03bc7c5ca95"} 2025-11-10T03:07:32.166Z INFO miner/protocol_block.go:376 verify block successful {"round": 220371, "block_size": 1, "time": "10.625697ms", "block": "906223b5bbf90cbc691f071137c13311ebc34a148b6711815536d03bc7c5ca95", "prev_block": "a18000018bdf9d386bd0ae02adf0990c907c8e27191a4622e0444af4795b6e84", "state_hash": "82d8333a677f834634b8d010f6e7603e3a3a4caeeac8b0c40e5830cd76a0091c", "state_status": 4} 2025-11-10T03:07:32.166Z DEBUG miner/protocol_block.go:374 SignBlock finished {"block": "906223b5bbf90cbc691f071137c13311ebc34a148b6711815536d03bc7c5ca95", "spent": "152.621µs"} 2025-11-10T03:07:32.166Z DEBUG miner/protocol_block.go:367 VerifyBlockMagicBlock finished {"block": "906223b5bbf90cbc691f071137c13311ebc34a148b6711815536d03bc7c5ca95", "spent": "1.02µs"} 2025-11-10T03:07:32.166Z DEBUG miner/protocol_block.go:360 verifySmartContracts finished {"block": "906223b5bbf90cbc691f071137c13311ebc34a148b6711815536d03bc7c5ca95", "spent": "1.33µs"} 2025-11-10T03:07:32.166Z DEBUG miner/protocol_block.go:351 verify block - ComputeState finished {"round": 220371, "block": "906223b5bbf90cbc691f071137c13311ebc34a148b6711815536d03bc7c5ca95", "spent": "8.415389ms"} 2025-11-10T03:07:32.166Z INFO block/entity.go:1034 compute state successful {"round": 220371, "block": "906223b5bbf90cbc691f071137c13311ebc34a148b6711815536d03bc7c5ca95", "block ptr": "0xc00f704960", "block_size": 1, "duration": "8.360439ms", "changes": 8, "begin_client_state": "7ccd2fdaee88218b39c4246285848ee7c89e6a3bcdfe3ad63fcf401dd7ec4208", "computed_state_hash": "82d8333a677f834634b8d010f6e7603e3a3a4caeeac8b0c40e5830cd76a0091c", "block_state_hash": "82d8333a677f834634b8d010f6e7603e3a3a4caeeac8b0c40e5830cd76a0091c", "prev_block": "a18000018bdf9d386bd0ae02adf0990c907c8e27191a4622e0444af4795b6e84", "prev_block_client_state": "7ccd2fdaee88218b39c4246285848ee7c89e6a3bcdfe3ad63fcf401dd7ec4208"} 2025-11-10T03:07:32.166Z DEBUG statecache/statecache.go:131 statecache - commit {"block": "906223b5bbf90cbc691f071137c13311ebc34a148b6711815536d03bc7c5ca95", "bc_hits": 54, "bc_miss": 0, "sc_hits": 20104850, "sc_miss": 6214, "duration": "300.313µs"} 2025-11-10T03:07:32.165Z DEBUG chain/state.go:961 Updating nonce {"client": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "new_nonce": 113218} 2025-11-10T03:07:32.164Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T03:07:32.164Z INFO chain/state.go:533 SC executed {"client id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "block": "906223b5bbf90cbc691f071137c13311ebc34a148b6711815536d03bc7c5ca95", "round": 220371, "prev_state_hash": "7ccd2fdaee88218b39c4246285848ee7c89e6a3bcdfe3ad63fcf401dd7ec4208", "txn_hash": "8e67cf62d9783eed39fcd4c8485b0f40ffa2bf25423c5e990ad40254eb5bae5d", "txn_nonce": 113218, "txn_func": "payFees", "txn_status": 1, "txn_exec_time": "6.552244ms", "begin client state": "7ccd2fdaee88218b39c4246285848ee7c89e6a3bcdfe3ad63fcf401dd7ec4208", "current_root": "b2b137f7414e7293c0306469d6a21467b2d58029f9334d11d2c844a2710988a6", "mpt_cache_hit": 42, "mpt_cache_miss": 0, "output": ""} 2025-11-10T03:07:32.164Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T03:07:32.164Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T03:07:32.163Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T03:07:32.163Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T03:07:32.158Z ERROR minersc/global_node.go:372 failed to get current magic block {"error": "value not present"} 2025-11-10T03:07:32.158Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "6dba10422e368813802877a85039d3985d96760ed844092319743fb3a76712d9d2208fe938b7465b9c5dc571053986cf8dbf3585fb36399f98ea569c42f50b76"} 2025-11-10T03:07:32.158Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "6dba10422e368813802877a85039d3985d96760ed844092319743fb3a76712d9b5e8a1650666fdd3a9de7855b6da63ab629b1701f23738477e2325f7ca2150ac"} 2025-11-10T03:07:32.158Z DEBUG minersc/fees.go:480 pay_fees, got miner id successfully {"miner id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "round": 220371, "block": "906223b5bbf90cbc691f071137c13311ebc34a148b6711815536d03bc7c5ca95"} 2025-11-10T03:07:32.158Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T03:07:32.158Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T03:07:32.158Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T03:07:32.157Z DEBUG miner/protocol_block.go:339 ValidateBlockCost {"round": 220371, "hash": "906223b5bbf90cbc691f071137c13311ebc34a148b6711815536d03bc7c5ca95", "calculated cost": 0} 2025-11-10T03:07:32.157Z DEBUG miner/protocol_block.go:305 ValidateTransactions finished {"block": "906223b5bbf90cbc691f071137c13311ebc34a148b6711815536d03bc7c5ca95", "spent": "1.046828ms"} 2025-11-10T03:07:32.157Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"verification_ticket","value":"Verification Ticket"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "duration": "1.759634ms"} 2025-11-10T03:07:32.157Z INFO miner/protocol_round.go:1127 checkBlockNotarization -- block is not Notarized. Returning {"round": 220371, "block hash": "906223b5bbf90cbc691f071137c13311ebc34a148b6711815536d03bc7c5ca95"} 2025-11-10T03:07:32.157Z INFO chain/protocol_block.go:225 not reached notarization {"mb_sr": 0, "active_miners": 3, "threshold": 2, "num_signatures": 1, "current_round": 220371, "round": 220371} 2025-11-10T03:07:32.157Z DEBUG miner/protocol_receive.go:298 handle vt. msg - verify ticket successfully {"round": 220371, "block": "906223b5bbf90cbc691f071137c13311ebc34a148b6711815536d03bc7c5ca95", "verifier": 0} 2025-11-10T03:07:32.156Z DEBUG miner/protocol_block.go:299 GetPreviousBlock finished {"block": "906223b5bbf90cbc691f071137c13311ebc34a148b6711815536d03bc7c5ca95", "spent": "1.13µs"} 2025-11-10T03:07:32.156Z DEBUG miner/protocol_block.go:292 VerifyBlockMagicBlockReference finished {"block": "906223b5bbf90cbc691f071137c13311ebc34a148b6711815536d03bc7c5ca95", "spent": "2.45µs"} 2025-11-10T03:07:32.156Z DEBUG miner/protocol_block.go:286 Validating finished {"block": "906223b5bbf90cbc691f071137c13311ebc34a148b6711815536d03bc7c5ca95", "spent": "642.155µs"} 2025-11-10T03:07:32.155Z DEBUG miner/protocol_round.go:1067 verify round block - started verification {"block": "906223b5bbf90cbc691f071137c13311ebc34a148b6711815536d03bc7c5ca95"} 2025-11-10T03:07:32.155Z DEBUG miner/protocol_round.go:1040 verify round block {"round": 220371, "block": "906223b5bbf90cbc691f071137c13311ebc34a148b6711815536d03bc7c5ca95"} 2025-11-10T03:07:32.155Z DEBUG miner/protocol_round.go:865 verifyAndSend - started {"block": "906223b5bbf90cbc691f071137c13311ebc34a148b6711815536d03bc7c5ca95"} 2025-11-10T03:07:32.155Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 220371, "randk": 1, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T03:07:32.155Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 220371, "randk": 0, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T03:07:32.155Z INFO miner/protocol_round.go:951 Started main verification loop {"round": 220371} 2025-11-10T03:07:32.155Z DEBUG miner/worker.go:53 message {"msg": {"code":"verification_ticket","value":"Verification Ticket"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71"} 2025-11-10T03:07:32.154Z DEBUG miner/m_handler.go:365 handle vt. msg - verification ticket {"round": 220371, "block": "906223b5bbf90cbc691f071137c13311ebc34a148b6711815536d03bc7c5ca95"} 2025-11-10T03:07:32.138Z DEBUG chain/protocol_lfb_ticket.go:386 update lfb ticket - ticket.Round <= latest.Round {"ticket.Round": 220367, "latest.Round": 220367} 2025-11-10T03:07:32.105Z DEBUG chain/entity.go:440 process block, no block in buffer {"current round": 220371} 2025-11-10T03:07:32.080Z DEBUG chain/protocol_lfb_ticket.go:386 update lfb ticket - ticket.Round <= latest.Round {"ticket.Round": 220367, "latest.Round": 220367} 2025-11-10T03:07:32.028Z INFO memorystore/collection.go:65 Redis returned 0 rows after seclect 2025-11-10T03:07:32.005Z DEBUG chain/entity.go:440 process block, no block in buffer {"current round": 220371} 2025-11-10T03:07:31.987Z DEBUG miner/protocol_round.go:1028 verify block - pending {"round": 220371, "block": "1d44f0d929d22e1dc91d55fa604d71063a5ab07bdc2c34ca734d5b5c40e3ce96"} 2025-11-10T03:07:31.987Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 220371, "randk": 1, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T03:07:31.987Z DEBUG miner/round.go:143 Adding block to verifyChannel {"round": 220371, "block hash": "1d44f0d929d22e1dc91d55fa604d71063a5ab07bdc2c34ca734d5b5c40e3ce96", "magic block": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "magic block round": 0} 2025-11-10T03:07:31.987Z INFO miner/protocol_round.go:803 adding block to verify {"round": 220371, "block": "1d44f0d929d22e1dc91d55fa604d71063a5ab07bdc2c34ca734d5b5c40e3ce96", "prev_block": "a18000018bdf9d386bd0ae02adf0990c907c8e27191a4622e0444af4795b6e84", "state_hash": "91986b0602075e449c44313594ada97dab136574f9417b83b674c2e8a64f47fa", "weight": 0.5} 2025-11-10T03:07:31.987Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 220371, "randk": 1, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T03:07:31.987Z DEBUG statecache/statecache.go:131 statecache - commit {"block": "1d44f0d929d22e1dc91d55fa604d71063a5ab07bdc2c34ca734d5b5c40e3ce96", "bc_hits": 54, "bc_miss": 0, "sc_hits": 20104796, "sc_miss": 6214, "duration": "225.462µs"} 2025-11-10T03:07:31.987Z INFO miner/protocol_block.go:1316 generate block (assemble+update+sign) {"round": 220371, "block_size": 1, "reused_txns": 0, "reused_txns": 0, "time": "12.315282ms", "block": "1d44f0d929d22e1dc91d55fa604d71063a5ab07bdc2c34ca734d5b5c40e3ce96", "prev_block": "a18000018bdf9d386bd0ae02adf0990c907c8e27191a4622e0444af4795b6e84", "begin_state_hash": "7ccd2fdaee88218b39c4246285848ee7c89e6a3bcdfe3ad63fcf401dd7ec4208", "block_state_hash": "91986b0602075e449c44313594ada97dab136574f9417b83b674c2e8a64f47fa", "computed_state_hash": "91986b0602075e449c44313594ada97dab136574f9417b83b674c2e8a64f47fa", "changes": 9, "state_status": 4, "iteration_count": 0} 2025-11-10T03:07:31.987Z DEBUG miner/protocol_block.go:1305 generate block (assemble+update) {"round": 220371, "txns": 1, "time": "12.18993ms"} 2025-11-10T03:07:31.987Z DEBUG miner/protocol_block.go:1282 generate block (assemble) {"round": 220371, "txns": 1, "time": "12.15782ms"} 2025-11-10T03:07:31.986Z DEBUG chain/state.go:961 Updating nonce {"client": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "new_nonce": 112406} 2025-11-10T03:07:31.986Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T03:07:31.986Z INFO chain/state.go:533 SC executed {"client id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "block": "", "round": 220371, "prev_state_hash": "7ccd2fdaee88218b39c4246285848ee7c89e6a3bcdfe3ad63fcf401dd7ec4208", "txn_hash": "3a1916adaf9b4b1921f4c31e583013b2f893740726578cbaf4a2a11829facda9", "txn_nonce": 112406, "txn_func": "payFees", "txn_status": 0, "txn_exec_time": "8.359589ms", "begin client state": "7ccd2fdaee88218b39c4246285848ee7c89e6a3bcdfe3ad63fcf401dd7ec4208", "current_root": "a5005d7a913d4df765dccbe90d644cb48f89e4b6b2ffeef0ba13598cff4bd88f", "mpt_cache_hit": 42, "mpt_cache_miss": 0, "output": ""} 2025-11-10T03:07:31.985Z DEBUG miner/protocol_round.go:1028 verify block - pending {"round": 220371, "block": "906223b5bbf90cbc691f071137c13311ebc34a148b6711815536d03bc7c5ca95"} 2025-11-10T03:07:31.985Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 220371, "randk": 0, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T03:07:31.985Z DEBUG miner/protocol_receive.go:130 verify block processed {"round": 220371, "block": "906223b5bbf90cbc691f071137c13311ebc34a148b6711815536d03bc7c5ca95"} 2025-11-10T03:07:31.985Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T03:07:31.985Z DEBUG miner/round.go:143 Adding block to verifyChannel {"round": 220371, "block hash": "906223b5bbf90cbc691f071137c13311ebc34a148b6711815536d03bc7c5ca95", "magic block": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "magic block round": 0} 2025-11-10T03:07:31.985Z DEBUG miner/protocol_round.go:759 update prev block notarization, already notarized {"round": 220370, "block": "a18000018bdf9d386bd0ae02adf0990c907c8e27191a4622e0444af4795b6e84"} 2025-11-10T03:07:31.985Z INFO miner/protocol_round.go:803 adding block to verify {"round": 220371, "block": "906223b5bbf90cbc691f071137c13311ebc34a148b6711815536d03bc7c5ca95", "prev_block": "a18000018bdf9d386bd0ae02adf0990c907c8e27191a4622e0444af4795b6e84", "state_hash": "82d8333a677f834634b8d010f6e7603e3a3a4caeeac8b0c40e5830cd76a0091c", "weight": 1} 2025-11-10T03:07:31.985Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T03:07:31.985Z INFO miner/protocol_round.go:613 handle verify block - added block for ticket verification {"round": 220371, "block": "906223b5bbf90cbc691f071137c13311ebc34a148b6711815536d03bc7c5ca95", "magic block": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "magic block round": 0} 2025-11-10T03:07:31.985Z INFO chain/protocol_block.go:225 not reached notarization {"mb_sr": 0, "active_miners": 3, "threshold": 2, "num_signatures": 0, "current_round": 220371, "round": 220371} 2025-11-10T03:07:31.984Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T03:07:31.984Z DEBUG miner/protocol_receive.go:169 verify block {"round": 220371, "block": "906223b5bbf90cbc691f071137c13311ebc34a148b6711815536d03bc7c5ca95"} 2025-11-10T03:07:31.984Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"verify_block","value":"Verify Block"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "duration": "43.561µs"} 2025-11-10T03:07:31.984Z DEBUG miner/worker.go:53 message {"msg": {"code":"verify_block","value":"Verify Block"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71"} 2025-11-10T03:07:31.984Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T03:07:31.978Z ERROR minersc/global_node.go:372 failed to get current magic block {"error": "value not present"} 2025-11-10T03:07:31.978Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "6dba10422e368813802877a85039d3985d96760ed844092319743fb3a76712d9d2208fe938b7465b9c5dc571053986cf8dbf3585fb36399f98ea569c42f50b76"} 2025-11-10T03:07:31.978Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "6dba10422e368813802877a85039d3985d96760ed844092319743fb3a76712d9b5e8a1650666fdd3a9de7855b6da63ab629b1701f23738477e2325f7ca2150ac"} 2025-11-10T03:07:31.978Z DEBUG minersc/fees.go:480 pay_fees, got miner id successfully {"miner id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "round": 220371, "block": ""} 2025-11-10T03:07:31.977Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T03:07:31.977Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T03:07:31.977Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T03:07:31.977Z DEBUG chain/protocol_view_change.go:424 [mvc] nonce, set nonce in getCurrentSelfNonce {"nonce": 112405} 2025-11-10T03:07:31.977Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\ufffdNPK\ufffdp\u001aX\u0005\ufffd\ufffd\n\ufffd\ufffd\ufffd\ufffd\u000ex\ufffd\u000f\ufffdq\ufffd\ufffd\ufffd\ufffd\ufffd&\ufffd#\ufffd%"} 2025-11-10T03:07:31.977Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\u0010\ufffdC\ufffd\r\ufffd\ufffd\ufffd\ufffdu\ufffdá$\ufffd\ufffd\ufffd\ufffd\u0014\ufffdx\ufffd+\u001el\ufffd!u\ufffd\ufffd+\ufffd"} 2025-11-10T03:07:31.977Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\ufffd\ufffd(\ufffd\ufffd\ufffdz\ufffd\u0014\ufffd\ufffd\ufffd\ufffd6\ufffdTTn\ufffdj^\u0002>\ufffd\u001bS᫫\ufffdAx"} 2025-11-10T03:07:31.976Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\ufffd}\ufffd\ufffdc8\ufffd\ufffd\ufffd\ufffd\ufffd\u001e\n\ufffd\ufffd\ufffd]\ufffd\ufffd\u001d\u0002؅\ufffd\ufffd>\u0006g{Z\ufffd\ufffd"} 2025-11-10T03:07:31.976Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "|\ufffd/\ufffd\ufffd\ufffd!\ufffd9\ufffd$b\ufffd\ufffd\ufffd\ufffdȞj;\ufffd\ufffd:\ufffd?\ufffd@\u001d\ufffd\ufffdB\u0008"} 2025-11-10T03:07:31.976Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T03:07:31.976Z DEBUG chain/protocol_view_change.go:431 [mvc] nonce, get current miner nonce {"minerId": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341"} 2025-11-10T03:07:31.976Z INFO memorystore/collection.go:65 Redis returned 0 rows after seclect 2025-11-10T03:07:31.976Z INFO miner/protocol_block.go:1112 generate block starting iteration {"round": 220371, "prev_block": "a18000018bdf9d386bd0ae02adf0990c907c8e27191a4622e0444af4795b6e84", "prev_state_hash": "7ccd2fdaee88218b39c4246285848ee7c89e6a3bcdfe3ad63fcf401dd7ec4208"} 2025-11-10T03:07:31.976Z DEBUG statecache/statecache.go:173 state cache - see gap {"block": "882f02d1a21ff33e5869b48b22636ae9e347097a5f2a60fe17bc24c417618cf2"} 2025-11-10T03:07:31.975Z DEBUG statecache/statecache.go:173 state cache - see gap {"block": "882f02d1a21ff33e5869b48b22636ae9e347097a5f2a60fe17bc24c417618cf2"} 2025-11-10T03:07:31.975Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"vrf_share","value":"VRF Share"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "duration": "91.541µs"} 2025-11-10T03:07:31.975Z INFO miner/protocol_bls.go:357 Ignoring VRFShare. Already at threshold {"Round": 220371, "VRF_Shares": 2, "bls_threshold": 2} 2025-11-10T03:07:31.975Z DEBUG miner/protocol_receive.go:26 handle vrf share {"round": 220371, "vrf_timeout_count": 0, "sender_index": 0} 2025-11-10T03:07:31.975Z DEBUG miner/worker.go:53 message {"msg": {"code":"vrf_share","value":"VRF Share"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71"} 2025-11-10T03:07:31.975Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 220371, "randk": 1, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T03:07:31.975Z DEBUG miner/protocol_round.go:467 Setting LFMB round/hash for a block {"rn": 220371, "mc.crn": 220371, "rnoff": 220346, "nvc": 0, "r": 0, "h": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "b.lfmbr": 0, "b.lfmbh": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4"} 2025-11-10T03:07:31.975Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"vrf_share","value":"VRF Share"}, "sender_index": 0, "id": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "duration": "2.169498ms"} 2025-11-10T03:07:31.974Z INFO miner/protocol_round.go:830 Starting round verification {"round": 220371, "delta": "180ms"} 2025-11-10T03:07:31.974Z INFO round/entity.go:618 get miners by rank {"num_miners": 3, "round": 220371, "r.minerPerm": [0, 1, 2]} 2025-11-10T03:07:31.974Z INFO miner/protocol_round.go:340 *** TOC_FIX starting round block generation *** {"round": 220371, "index": 1, "rank": 1, "timeout_count": 0, "random_seed": 7492188637680439031, "lf_round": 220367} 2025-11-10T03:07:31.974Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"vrf_share","value":"VRF Share"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "duration": "112.79µs"} 2025-11-10T03:07:31.974Z INFO miner/protocol_bls.go:357 Ignoring VRFShare. Already at threshold {"Round": 220371, "VRF_Shares": 2, "bls_threshold": 2} 2025-11-10T03:07:31.974Z INFO miner/protocol_bls.go:591 Starting round with vrf {"round": 220371, "roundtimeout": 0, "rseed": 7492188637680439031, "prev_round": 220370, "Prev_rseed": 0} 2025-11-10T03:07:31.974Z DEBUG miner/protocol_bls.go:542 DKG computeRBO {"round": 220371} 2025-11-10T03:07:31.974Z DEBUG miner/protocol_receive.go:26 handle vrf share {"round": 220371, "vrf_timeout_count": 0, "sender_index": 0} 2025-11-10T03:07:31.974Z INFO miner/protocol_bls.go:524 receive bls sign {"round": 220371, "group_signature": "1 5d1278f72727a6c6e5e82a957145a58889ca5e3d9138d31e9b672ba6b85921d 14cdf8ccf082e44203e79fd4406d7494a3579356da0a9b5656f8a0bf6016029e", "rboOutput": "67f999dee3290ef7348d5c4c9f10f163ced2f01a9c6c0a985c4e717a1208fa00", "dkg_starting_round": 0, "dkg_mb_number": 1} 2025-11-10T03:07:31.974Z DEBUG miner/worker.go:53 message {"msg": {"code":"vrf_share","value":"VRF Share"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71"} 2025-11-10T03:07:31.974Z DEBUG miner/protocol_bls.go:496 VRF Hurray we've threshold BLS shares {"round": 220371, "round pointer": "0xc016f61b90"} 2025-11-10T03:07:31.974Z DEBUG round/entity.go:684 add_vrf_share {"round": 220371, "round_vrf_num": 2, "threshold": 2} 2025-11-10T03:07:31.974Z INFO miner/protocol_bls.go:430 verified vrf {"round": 220371, "node_id": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "share": "1 183b9e45e66fbec02c3c56f276b465fa594cce1d08bd2fa8785999051da20aaa 2334280f4231bf0f034ecceb359e90c2614121f14656fe933ebca9131723dd4b", "from": "1c3227e496fdf3c9aa604f3470a2bbd1", "message": "22037102d3f8b50a751e036"} 2025-11-10T03:07:31.973Z DEBUG bls/dkg.go:396 dkg verify {"id": "1c3227e496fdf3c9aa604f3470a2bbd1", "key": "1 6603e20478fac2c72a61b85056977b92696b8fffd408d8acac0e1f47aed3f96 1501242ed9000d9c6a02764160261164a52360a692c34ed452ff097bc90ee9b3 7f8aaa178d31fa4cbd0c1974768dfa4921e29405754ebf8d2c163a774b741a2 24515e04bd685a5559260f5d1868e5ea11abaf21f55a56aee52c15d9f3c2b053", "msg": "22037102d3f8b50a751e036", "sig": "1 183b9e45e66fbec02c3c56f276b465fa594cce1d08bd2fa8785999051da20aaa 2334280f4231bf0f034ecceb359e90c2614121f14656fe933ebca9131723dd4b"} 2025-11-10T03:07:31.972Z INFO miner/protocol_bls.go:265 BLS sign VRF share calculated for {"round": 220371, "round_timeout": 0, "prev_rseed": 3260477833760333878, "prev round vrf random seed": "2d3f8b50a751e036", "bls_msg": "22037102d3f8b50a751e036"} 2025-11-10T03:07:31.972Z INFO miner/protocol_bls.go:364 DKG AddVRFShare {"round": 220371, "round_vrf_num": 1, "threshold": 2, "sender": 0, "round_timeout_count": 0, "vrf_timeout_count": 0, "vrf_share": "1 183b9e45e66fbec02c3c56f276b465fa594cce1d08bd2fa8785999051da20aaa 2334280f4231bf0f034ecceb359e90c2614121f14656fe933ebca9131723dd4b"} 2025-11-10T03:07:31.972Z DEBUG miner/protocol_receive.go:26 handle vrf share {"round": 220371, "vrf_timeout_count": 0, "sender_index": 0} 2025-11-10T03:07:31.972Z DEBUG miner/worker.go:53 message {"msg": {"code":"vrf_share","value":"VRF Share"}, "sender_index": 0, "id": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea"} 2025-11-10T03:07:31.968Z INFO chain/entity.go:1721 delete blocks below round {"round": 220371, "below_round": 220317, "before": 1762743991, "total": 312, "count": 0} 2025-11-10T03:07:31.968Z DEBUG chain/protocol_round.go:334 finalize round - block has less than 3 confirmation 2025-11-10T03:07:31.968Z DEBUG chain/protocol_round.go:334 finalize round - block has less than 3 confirmation 2025-11-10T03:07:31.968Z INFO chain/protocol_round.go:402 finalize round - finalize block success {"round": 220367, "block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e", "duration": "4.075684ms"} 2025-11-10T03:07:31.968Z DEBUG chain/worker.go:230 finalize block processed {"round": 220367, "duration": "4.023073ms"} 2025-11-10T03:07:31.968Z DEBUG chain/protocol_block.go:612 finalized block - done {"round": 220367, "block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e", "duration": "3.880262ms"} 2025-11-10T03:07:31.968Z INFO chain/entity.go:2366 config has been updated successfully {"start of round": 220367} 2025-11-10T03:07:31.967Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\ufffd\u001e\ufffd-7cq\u000e\ufffd\ufffdz\ufffdz\ufffd\ufffd\u0012\ufffdD\u001b\ufffdlj罦\ufffd\ufffd\u0003\ufffd'\ufffd}"} 2025-11-10T03:07:31.967Z DEBUG transaction/worker.go:253 [mvc] see no old txns {"clientID": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "nonce": 112404} 2025-11-10T03:07:31.967Z INFO memorystore/collection.go:65 Redis returned 0 rows after seclect 2025-11-10T03:07:31.967Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\ufffd1f\u000b\ufffd\ufffdq[\ufffd\ufffd\ufffd`)x\ufffd\ufffdw\ufffdj:\ufffdH\u0001\ufffd⩲\ufffd\ufffd\ufffd\ufffd\ufffd"} 2025-11-10T03:07:31.967Z DEBUG transaction/worker.go:221 [mvc] remove old nonce txns {"clientID": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "nonce": 112404} 2025-11-10T03:07:31.967Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "-B\ufffd{\ufffdD\ufffdL\ufffd\ufffd\ufffd\ufffd\ufffd\u0011\u0006V\ufffd\u0008\u0011\ufffd+\ufffd\ufffd35\ufffd\u0019\ufffdL\ufffd+\ufffd"} 2025-11-10T03:07:31.967Z DEBUG chain/worker.go:443 BC is moving {"current_lfb_round": 220367, "last_round": 220366} 2025-11-10T03:07:31.967Z DEBUG chain/lfb_round_node.go:33 [mvc] store lfb {"round": 220367, "block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e", "mb number": 1} 2025-11-10T03:07:31.967Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\ufffdse\ufffd<\ufffd\ufffd\ufffd\ufffd\u0018\u001a\ufffd\ufffd\ufffd;\ufffd\ufffdR\ufffd{IEÊO\u0010\ufffd\ufffdЊT"} 2025-11-10T03:07:31.967Z DEBUG chain/entity.go:2269 set lfb {"round": 220367, "block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e", "state_computed": true} 2025-11-10T03:07:31.967Z INFO transaction/worker.go:164 cleaning transactions {"collection": "collection.txn:0afc093ffb509f059c55478bc1a60351cef7b4e9c008a53a6cc8241ca8617dfe", "missing_count": 1, "txns": ["7e0508a76d40253844e7dbd3f696086e8083f59bc2349e6d24b504693a1c05ef"], "past txns": []} 2025-11-10T03:07:31.967Z DEBUG chain/state.go:128 finalize round - rebased current state db {"round": 220367, "block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e", "state hash": "0bfec0f92e39abafd9673edecc2bce26d769b6e8d1a0aaeeef98490e1d08a094"} 2025-11-10T03:07:31.967Z INFO memorystore/collection.go:65 Redis returned 0 rows after seclect 2025-11-10T03:07:31.967Z DEBUG util/mpt_nodedb.go:556 LevelNodeDB rebase db 2025-11-10T03:07:31.967Z DEBUG transaction/worker.go:124 cleaning past transactions 2025-11-10T03:07:31.967Z DEBUG miner/round.go:238 Round clear - cancel verification 2025-11-10T03:07:31.967Z DEBUG chain/protocol_block.go:424 finalize block - record dead nodes {"round": 220367, "block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e", "num dead nodes": 8} 2025-11-10T03:07:31.966Z DEBUG miner/chain.go:313 delete txns {"txns": ["7e0508a76d40253844e7dbd3f696086e8083f59bc2349e6d24b504693a1c05ef"]} 2025-11-10T03:07:31.966Z INFO miner/protocol_block.go:619 update finalized block (debug transaction) {"txn": "7e0508a76d40253844e7dbd3f696086e8083f59bc2349e6d24b504693a1c05ef", "block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e"} 2025-11-10T03:07:31.966Z INFO miner/protocol_block.go:613 update finalized block {"round": 220367, "block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e", "lf_round": 220366, "current_round": 220371, "weight": 1} 2025-11-10T03:07:31.966Z DEBUG chain/protocol_block.go:409 MPT state node stat - inc {"node num": -421001, "change num": 8, "delete num": 8} 2025-11-10T03:07:31.966Z INFO block/entity.go:1195 save state {"round": 220367, "block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e", "block_size": 1, "changes": 8, "client_state": "0bfec0f92e39abafd9673edecc2bce26d769b6e8d1a0aaeeef98490e1d08a094", "duration": "1.882695ms"} 2025-11-10T03:07:31.965Z DEBUG util/merkle_patricia_trie.go:272 MPT save changes success {"duration": "1.306631ms"} 2025-11-10T03:07:31.965Z DEBUG util/mpt_node_change.go:156 MPT - update changes done {"changes": 8} 2025-11-10T03:07:31.965Z INFO miner/protocol_bls.go:489 Not yet reached threshold {"vrfShares_num": 1, "threshold": 2, "round": 220371} 2025-11-10T03:07:31.965Z DEBUG round/entity.go:684 add_vrf_share {"round": 220371, "round_vrf_num": 1, "threshold": 2} 2025-11-10T03:07:31.965Z INFO miner/protocol_bls.go:430 verified vrf {"round": 220371, "node_id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "share": "1 1c2f6ff80d4d113ea72a1bd089dceaad33b8947d1d0942ab144cf853b89ac990 1b5678bfed6d5fb3663c1d69fcc2758128234a6b125d476b2ea800c856c26d27", "from": "196b96df7631e00d339f9a25131927c4", "message": "22037102d3f8b50a751e036"} 2025-11-10T03:07:31.964Z DEBUG util/mpt_node_change.go:150 MPT - update changes {"changes": 8} 2025-11-10T03:07:31.964Z DEBUG bls/dkg.go:396 dkg verify {"id": "196b96df7631e00d339f9a25131927c4", "key": "1 1f8c72cc3a6b74f6ad7528172b64afe3dc42ee1987495659fe2cf34e749caa7c 20957b4d25e7b5fb1e32d4e3b93e2b73dad7f118efb6dae28715e4ad627b0fff 14259a6ddf4b44c83c1389bd8ed1fc47c1b099c5986bb33923bbcbb25d30054a 2100bb7434dadde1a5ed8545748d0958955bcd21e06cf170f78dbda35a9e04b7", "msg": "22037102d3f8b50a751e036", "sig": "1 1c2f6ff80d4d113ea72a1bd089dceaad33b8947d1d0942ab144cf853b89ac990 1b5678bfed6d5fb3663c1d69fcc2758128234a6b125d476b2ea800c856c26d27"} 2025-11-10T03:07:31.964Z INFO round/entity.go:618 get miners by rank {"num_miners": 3, "round": 220367, "r.minerPerm": [0, 2, 1]} 2025-11-10T03:07:31.964Z INFO chain/protocol_block.go:363 finalize block -- round {"round": {"number":220367,"round_random_seed":-6331856494980129623,"block_hash":"5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e","vrf_output":"a820ba10bff59ca90cde84d17e5d1459d0701b8a93bf107518a59d22682299d9"}, "block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e"} 2025-11-10T03:07:31.964Z INFO chain/protocol_block.go:328 finalize block {"round": 220367, "current_round": 220371, "lf_round": 220366, "hash": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e", "round_rank": 0, "state": 7} 2025-11-10T03:07:31.964Z INFO miner/protocol_bls.go:265 BLS sign VRF share calculated for {"round": 220371, "round_timeout": 0, "prev_rseed": 3260477833760333878, "prev round vrf random seed": "2d3f8b50a751e036", "bls_msg": "22037102d3f8b50a751e036"} 2025-11-10T03:07:31.964Z DEBUG chain/worker.go:262 start to finalize block {"round": 220367, "block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e", "prev block": "590839da3aaffc06479d7d48fc9e523f958edee0826341a3e3e0f59b2532b1d2"} 2025-11-10T03:07:31.964Z INFO miner/protocol_bls.go:364 DKG AddVRFShare {"round": 220371, "round_vrf_num": 0, "threshold": 2, "sender": 1, "round_timeout_count": 0, "vrf_timeout_count": 0, "vrf_share": "1 1c2f6ff80d4d113ea72a1bd089dceaad33b8947d1d0942ab144cf853b89ac990 1b5678bfed6d5fb3663c1d69fcc2758128234a6b125d476b2ea800c856c26d27"} 2025-11-10T03:07:31.964Z INFO miner/protocol_round.go:78 add_my_vrf_share {"round": 220371, "round_timeout": 0, "dkg_starting_round": 0, "dkg_mb_number": 1, "pr_seed": 3260477833760333878, "pr_vrf_seed": "2d3f8b50a751e036", "share": "1 1c2f6ff80d4d113ea72a1bd089dceaad33b8947d1d0942ab144cf853b89ac990 1b5678bfed6d5fb3663c1d69fcc2758128234a6b125d476b2ea800c856c26d27"} 2025-11-10T03:07:31.964Z DEBUG miner/protocol_bls.go:305 get_bls_share {"round": 220371, "rtc": 0, "dkg_pi": "1 1f8c72cc3a6b74f6ad7528172b64afe3dc42ee1987495659fe2cf34e749caa7c 20957b4d25e7b5fb1e32d4e3b93e2b73dad7f118efb6dae28715e4ad627b0fff 14259a6ddf4b44c83c1389bd8ed1fc47c1b099c5986bb33923bbcbb25d30054a 2100bb7434dadde1a5ed8545748d0958955bcd21e06cf170f78dbda35a9e04b7", "dkg_sr": 0, "mb_sr": 0, "share": "1 1c2f6ff80d4d113ea72a1bd089dceaad33b8947d1d0942ab144cf853b89ac990 1b5678bfed6d5fb3663c1d69fcc2758128234a6b125d476b2ea800c856c26d27"} 2025-11-10T03:07:31.964Z INFO chain/protocol_round.go:359 finalize round {"round": 220367, "lfb round": 220369, "block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e"} 2025-11-10T03:07:31.964Z INFO chain/protocol_round.go:326 finalize round - latest finalized round {"round": 220370, "lfb round": 220369, "lfb block": "3d4993ea20c4b102f1dc90f05ff53719e0d26d938ca43f0ecdfe74b6953a8a08"} 2025-11-10T03:07:31.964Z INFO chain/protocol_round.go:199 finalize round {"round": 220370, "plfb_round": 220366, "num_round_notarized": 1, "num_chain_notarized": 3} 2025-11-10T03:07:31.963Z DEBUG chain/protocol_round.go:160 finalize round {"round": 220370, "lf_round": 220366} 2025-11-10T03:07:31.963Z DEBUG bls/dkg.go:356 dkg sign {"key": "1ef4cd5ccbeb2dfce1247caae9b2222f43537288563d8624eeb7f5102005c109", "pi": "1 1f8c72cc3a6b74f6ad7528172b64afe3dc42ee1987495659fe2cf34e749caa7c 20957b4d25e7b5fb1e32d4e3b93e2b73dad7f118efb6dae28715e4ad627b0fff 14259a6ddf4b44c83c1389bd8ed1fc47c1b099c5986bb33923bbcbb25d30054a 2100bb7434dadde1a5ed8545748d0958955bcd21e06cf170f78dbda35a9e04b7"} 2025-11-10T03:07:31.963Z DEBUG miner/protocol_bls.go:293 Sign msg with dkg {"msg": "22037102d3f8b50a751e036", "round": 220371, "dkg starting round": 0} 2025-11-10T03:07:31.963Z INFO miner/protocol_bls.go:265 BLS sign VRF share calculated for {"round": 220371, "round_timeout": 0, "prev_rseed": 3260477833760333878, "prev round vrf random seed": "2d3f8b50a751e036", "bls_msg": "22037102d3f8b50a751e036"} 2025-11-10T03:07:31.963Z INFO miner/protocol_bls.go:283 DKG getBlsShare {"Round Number": 220371} 2025-11-10T03:07:31.963Z INFO miner/protocol_round.go:244 StartNextRound - add VRF {"round": 220371} 2025-11-10T03:07:31.963Z INFO miner/round.go:40 Try to cancel block generation that have not been started yet {"round": 220370} 2025-11-10T03:07:31.963Z DEBUG miner/protocol_round.go:210 finalizedRound - cancel round verification {"round": 220370} 2025-11-10T03:07:31.963Z INFO chain/entity.go:2016 Moving to the next round {"next_round": 220371} 2025-11-10T03:07:31.963Z DEBUG miner/protocol_round.go:154 [wait not ahead] [2] not ahead, can move on {"round": 220370, "lfb tk round": 220366} 2025-11-10T03:07:31.963Z DEBUG miner/protocol_round.go:123 [wait not ahead] 2025-11-10T03:07:31.963Z DEBUG miner/protocol_round.go:991 verification_complete {"top_verified_rank": 0} 2025-11-10T03:07:31.963Z INFO miner/protocol_round.go:986 verification_complete {"round": 220370, "verified_blocks": 0} 2025-11-10T03:07:31.963Z DEBUG miner/protocol_round.go:943 verifyAndSend - finished successfully {"round": 220370, "block": "a18000018bdf9d386bd0ae02adf0990c907c8e27191a4622e0444af4795b6e84"} 2025-11-10T03:07:31.963Z INFO miner/round.go:44 Cancelling block generation {"round": 220370} 2025-11-10T03:07:31.963Z INFO miner/round.go:230 Cancelling verification {"round": 220370} 2025-11-10T03:07:31.963Z INFO miner/protocol_receive.go:456 process notarization - start next round {"new round": 220371} 2025-11-10T03:07:31.963Z DEBUG miner/protocol_round.go:1149 check block notarization - block notarized {"round": 220370, "block": "a18000018bdf9d386bd0ae02adf0990c907c8e27191a4622e0444af4795b6e84"} 2025-11-10T03:07:31.963Z DEBUG round/entity.go:344 reached notarization {"round": 220370} 2025-11-10T03:07:31.963Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 220370, "randk": 0, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T03:07:31.963Z INFO chain/entity.go:1571 Adding a notarized block for current round {"Round": 220370} 2025-11-10T03:07:31.963Z INFO chain/protocol_block.go:303 reached notarization - add tickets {"round": 220370, "current_round": 220370, "block": "a18000018bdf9d386bd0ae02adf0990c907c8e27191a4622e0444af4795b6e84", "tickets_num": 2} 2025-11-10T03:07:31.963Z INFO miner/protocol_round.go:920 verifyAndSend - sending verification ticket {"round": 220370, "block": "a18000018bdf9d386bd0ae02adf0990c907c8e27191a4622e0444af4795b6e84", "block_rank": 0, "RRS": 3260477833760333878} 2025-11-10T03:07:31.963Z INFO chain/protocol_block.go:319 reached notarization - merging tickets {"round": 220369, "current_round": 220370, "block": "3d4993ea20c4b102f1dc90f05ff53719e0d26d938ca43f0ecdfe74b6953a8a08", "tickets_num": 2} 2025-11-10T03:07:31.963Z DEBUG miner/protocol_round.go:1069 verify round block - finished verification {"block": "a18000018bdf9d386bd0ae02adf0990c907c8e27191a4622e0444af4795b6e84"} 2025-11-10T03:07:31.963Z INFO miner/protocol_block.go:376 verify block successful {"round": 220370, "block_size": 2, "time": "15.375956ms", "block": "a18000018bdf9d386bd0ae02adf0990c907c8e27191a4622e0444af4795b6e84", "prev_block": "3d4993ea20c4b102f1dc90f05ff53719e0d26d938ca43f0ecdfe74b6953a8a08", "state_hash": "7ccd2fdaee88218b39c4246285848ee7c89e6a3bcdfe3ad63fcf401dd7ec4208", "state_status": 4} 2025-11-10T03:07:31.963Z DEBUG miner/protocol_block.go:374 SignBlock finished {"block": "a18000018bdf9d386bd0ae02adf0990c907c8e27191a4622e0444af4795b6e84", "spent": "152.101µs"} 2025-11-10T03:07:31.963Z DEBUG miner/protocol_block.go:367 VerifyBlockMagicBlock finished {"block": "a18000018bdf9d386bd0ae02adf0990c907c8e27191a4622e0444af4795b6e84", "spent": "540ns"} 2025-11-10T03:07:31.963Z DEBUG miner/protocol_block.go:360 verifySmartContracts finished {"block": "a18000018bdf9d386bd0ae02adf0990c907c8e27191a4622e0444af4795b6e84", "spent": "4.511µs"} 2025-11-10T03:07:31.963Z DEBUG miner/protocol_block.go:351 verify block - ComputeState finished {"round": 220370, "block": "a18000018bdf9d386bd0ae02adf0990c907c8e27191a4622e0444af4795b6e84", "spent": "9.335907ms"} 2025-11-10T03:07:31.963Z INFO block/entity.go:1034 compute state successful {"round": 220370, "block": "a18000018bdf9d386bd0ae02adf0990c907c8e27191a4622e0444af4795b6e84", "block ptr": "0xc01bb8fa40", "block_size": 2, "duration": "9.275476ms", "changes": 9, "begin_client_state": "f2bccc58a481a3cf89575a16db751a17cb4450f11caa1cef16f9544599292b98", "computed_state_hash": "7ccd2fdaee88218b39c4246285848ee7c89e6a3bcdfe3ad63fcf401dd7ec4208", "block_state_hash": "7ccd2fdaee88218b39c4246285848ee7c89e6a3bcdfe3ad63fcf401dd7ec4208", "prev_block": "3d4993ea20c4b102f1dc90f05ff53719e0d26d938ca43f0ecdfe74b6953a8a08", "prev_block_client_state": "f2bccc58a481a3cf89575a16db751a17cb4450f11caa1cef16f9544599292b98"} 2025-11-10T03:07:31.963Z DEBUG statecache/statecache.go:131 statecache - commit {"block": "a18000018bdf9d386bd0ae02adf0990c907c8e27191a4622e0444af4795b6e84", "bc_hits": 76, "bc_miss": 0, "sc_hits": 20104742, "sc_miss": 6214, "duration": "310.363µs"} 2025-11-10T03:07:31.962Z DEBUG chain/state.go:961 Updating nonce {"client": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "new_nonce": 113217} 2025-11-10T03:07:31.962Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T03:07:31.962Z INFO chain/state.go:533 SC executed {"client id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "block": "a18000018bdf9d386bd0ae02adf0990c907c8e27191a4622e0444af4795b6e84", "round": 220370, "prev_state_hash": "f2bccc58a481a3cf89575a16db751a17cb4450f11caa1cef16f9544599292b98", "txn_hash": "cbe8870d80394725ad7032fe4471336cc3c6828f5bb75981ef47c61c8aefab91", "txn_nonce": 113217, "txn_func": "generate_challenge", "txn_status": 1, "txn_exec_time": "208.422µs", "begin client state": "d7b94fb64c1eedc0e3f4dfb470bc17f107ecd5fec0c6f23025f93cc8c77987d8", "current_root": "d7b94fb64c1eedc0e3f4dfb470bc17f107ecd5fec0c6f23025f93cc8c77987d8", "mpt_cache_hit": 9, "mpt_cache_miss": 0, "output": "OpenChallenges generated"} 2025-11-10T03:07:31.962Z INFO storagesc/challenge.go:1191 skipping generate challenge: empty blobber challenge partition 2025-11-10T03:07:31.962Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "eaf4195ad8a6c0bd8f90e9b28f4ba3b4938ddc60155952285997f669446bb502"} 2025-11-10T03:07:31.961Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T03:07:31.961Z DEBUG chain/state.go:961 Updating nonce {"client": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "new_nonce": 113216} 2025-11-10T03:07:31.960Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T03:07:31.960Z INFO chain/state.go:533 SC executed {"client id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "block": "a18000018bdf9d386bd0ae02adf0990c907c8e27191a4622e0444af4795b6e84", "round": 220370, "prev_state_hash": "f2bccc58a481a3cf89575a16db751a17cb4450f11caa1cef16f9544599292b98", "txn_hash": "9c0eac4cc325550c26d8358607ba8ad83c18836e9b2c7e8fd14c5dddf35d81f7", "txn_nonce": 113216, "txn_func": "payFees", "txn_status": 1, "txn_exec_time": "6.612984ms", "begin client state": "f2bccc58a481a3cf89575a16db751a17cb4450f11caa1cef16f9544599292b98", "current_root": "61a392f4db83ab164cb6e8ed6f41bc80d4a4115da4bbafc3aced46cdba8cd4db", "mpt_cache_hit": 43, "mpt_cache_miss": 0, "output": ""} 2025-11-10T03:07:31.960Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T03:07:31.960Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T03:07:31.960Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T03:07:31.959Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T03:07:31.957Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"verification_ticket","value":"Verification Ticket"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "duration": "1.15724ms"} 2025-11-10T03:07:31.957Z INFO miner/protocol_round.go:1127 checkBlockNotarization -- block is not Notarized. Returning {"round": 220370, "block hash": "a18000018bdf9d386bd0ae02adf0990c907c8e27191a4622e0444af4795b6e84"} 2025-11-10T03:07:31.957Z INFO chain/protocol_block.go:225 not reached notarization {"mb_sr": 0, "active_miners": 3, "threshold": 2, "num_signatures": 1, "current_round": 220370, "round": 220370} 2025-11-10T03:07:31.957Z DEBUG miner/protocol_receive.go:298 handle vt. msg - verify ticket successfully {"round": 220370, "block": "a18000018bdf9d386bd0ae02adf0990c907c8e27191a4622e0444af4795b6e84", "verifier": 0} 2025-11-10T03:07:31.956Z DEBUG miner/worker.go:53 message {"msg": {"code":"verification_ticket","value":"Verification Ticket"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71"} 2025-11-10T03:07:31.955Z DEBUG miner/m_handler.go:365 handle vt. msg - verification ticket {"round": 220370, "block": "a18000018bdf9d386bd0ae02adf0990c907c8e27191a4622e0444af4795b6e84"} 2025-11-10T03:07:31.955Z ERROR minersc/global_node.go:372 failed to get current magic block {"error": "value not present"} 2025-11-10T03:07:31.954Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "6dba10422e368813802877a85039d3985d96760ed844092319743fb3a76712d9d2208fe938b7465b9c5dc571053986cf8dbf3585fb36399f98ea569c42f50b76"} 2025-11-10T03:07:31.954Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "6dba10422e368813802877a85039d3985d96760ed844092319743fb3a76712d9b5e8a1650666fdd3a9de7855b6da63ab629b1701f23738477e2325f7ca2150ac"} 2025-11-10T03:07:31.954Z DEBUG minersc/fees.go:480 pay_fees, got miner id successfully {"miner id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "round": 220370, "block": "a18000018bdf9d386bd0ae02adf0990c907c8e27191a4622e0444af4795b6e84"} 2025-11-10T03:07:31.954Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T03:07:31.954Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T03:07:31.953Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T03:07:31.953Z DEBUG miner/protocol_block.go:339 ValidateBlockCost {"round": 220370, "hash": "a18000018bdf9d386bd0ae02adf0990c907c8e27191a4622e0444af4795b6e84", "calculated cost": 100} 2025-11-10T03:07:31.953Z DEBUG statecache/statecache.go:173 state cache - see gap {"block": "882f02d1a21ff33e5869b48b22636ae9e347097a5f2a60fe17bc24c417618cf2"} 2025-11-10T03:07:31.952Z DEBUG statecache/statecache.go:173 state cache - see gap {"block": "882f02d1a21ff33e5869b48b22636ae9e347097a5f2a60fe17bc24c417618cf2"} 2025-11-10T03:07:31.951Z DEBUG miner/protocol_block.go:305 ValidateTransactions finished {"block": "a18000018bdf9d386bd0ae02adf0990c907c8e27191a4622e0444af4795b6e84", "spent": "2.610512ms"} 2025-11-10T03:07:31.949Z DEBUG miner/protocol_block.go:299 GetPreviousBlock finished {"block": "a18000018bdf9d386bd0ae02adf0990c907c8e27191a4622e0444af4795b6e84", "spent": "1.2µs"} 2025-11-10T03:07:31.949Z DEBUG miner/protocol_block.go:292 VerifyBlockMagicBlockReference finished {"block": "a18000018bdf9d386bd0ae02adf0990c907c8e27191a4622e0444af4795b6e84", "spent": "3.67µs"} 2025-11-10T03:07:31.949Z DEBUG miner/protocol_block.go:286 Validating finished {"block": "a18000018bdf9d386bd0ae02adf0990c907c8e27191a4622e0444af4795b6e84", "spent": "1.078498ms"} 2025-11-10T03:07:31.948Z DEBUG miner/protocol_round.go:1067 verify round block - started verification {"block": "a18000018bdf9d386bd0ae02adf0990c907c8e27191a4622e0444af4795b6e84"} 2025-11-10T03:07:31.948Z DEBUG miner/protocol_round.go:1040 verify round block {"round": 220370, "block": "a18000018bdf9d386bd0ae02adf0990c907c8e27191a4622e0444af4795b6e84"} 2025-11-10T03:07:31.947Z DEBUG miner/protocol_round.go:865 verifyAndSend - started {"block": "a18000018bdf9d386bd0ae02adf0990c907c8e27191a4622e0444af4795b6e84"} 2025-11-10T03:07:31.947Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 220370, "randk": 1, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T03:07:31.947Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 220370, "randk": 0, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T03:07:31.947Z INFO miner/protocol_round.go:951 Started main verification loop {"round": 220370} 2025-11-10T03:07:31.918Z DEBUG chain/protocol_lfb_ticket.go:386 update lfb ticket - ticket.Round <= latest.Round {"ticket.Round": 220366, "latest.Round": 220366} 2025-11-10T03:07:31.905Z DEBUG chain/entity.go:440 process block, no block in buffer {"current round": 220370} 2025-11-10T03:07:31.863Z DEBUG chain/protocol_lfb_ticket.go:386 update lfb ticket - ticket.Round <= latest.Round {"ticket.Round": 220366, "latest.Round": 220366} 2025-11-10T03:07:31.804Z DEBUG chain/entity.go:440 process block, no block in buffer {"current round": 220370} 2025-11-10T03:07:31.793Z DEBUG miner/protocol_round.go:1028 verify block - pending {"round": 220370, "block": "a18000018bdf9d386bd0ae02adf0990c907c8e27191a4622e0444af4795b6e84"} 2025-11-10T03:07:31.793Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 220370, "randk": 0, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T03:07:31.793Z DEBUG miner/protocol_receive.go:130 verify block processed {"round": 220370, "block": "a18000018bdf9d386bd0ae02adf0990c907c8e27191a4622e0444af4795b6e84"} 2025-11-10T03:07:31.793Z DEBUG miner/protocol_round.go:759 update prev block notarization, already notarized {"round": 220369, "block": "3d4993ea20c4b102f1dc90f05ff53719e0d26d938ca43f0ecdfe74b6953a8a08"} 2025-11-10T03:07:31.793Z DEBUG miner/round.go:143 Adding block to verifyChannel {"round": 220370, "block hash": "a18000018bdf9d386bd0ae02adf0990c907c8e27191a4622e0444af4795b6e84", "magic block": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "magic block round": 0} 2025-11-10T03:07:31.793Z INFO miner/protocol_round.go:803 adding block to verify {"round": 220370, "block": "a18000018bdf9d386bd0ae02adf0990c907c8e27191a4622e0444af4795b6e84", "prev_block": "3d4993ea20c4b102f1dc90f05ff53719e0d26d938ca43f0ecdfe74b6953a8a08", "state_hash": "7ccd2fdaee88218b39c4246285848ee7c89e6a3bcdfe3ad63fcf401dd7ec4208", "weight": 1} 2025-11-10T03:07:31.793Z INFO miner/protocol_round.go:613 handle verify block - added block for ticket verification {"round": 220370, "block": "a18000018bdf9d386bd0ae02adf0990c907c8e27191a4622e0444af4795b6e84", "magic block": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "magic block round": 0} 2025-11-10T03:07:31.793Z INFO chain/protocol_block.go:225 not reached notarization {"mb_sr": 0, "active_miners": 3, "threshold": 2, "num_signatures": 0, "current_round": 220370, "round": 220370} 2025-11-10T03:07:31.792Z DEBUG miner/protocol_receive.go:169 verify block {"round": 220370, "block": "a18000018bdf9d386bd0ae02adf0990c907c8e27191a4622e0444af4795b6e84"} 2025-11-10T03:07:31.792Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"verify_block","value":"Verify Block"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "duration": "48.77µs"} 2025-11-10T03:07:31.792Z DEBUG miner/worker.go:53 message {"msg": {"code":"verify_block","value":"Verify Block"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71"} 2025-11-10T03:07:31.783Z DEBUG miner/protocol_round.go:1028 verify block - pending {"round": 220370, "block": "8ddceef774063be626131c9009469ee25ad379423fa8af6e59bc9d24397675ea"} 2025-11-10T03:07:31.783Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 220370, "randk": 1, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T03:07:31.783Z DEBUG miner/round.go:143 Adding block to verifyChannel {"round": 220370, "block hash": "8ddceef774063be626131c9009469ee25ad379423fa8af6e59bc9d24397675ea", "magic block": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "magic block round": 0} 2025-11-10T03:07:31.783Z INFO miner/protocol_round.go:803 adding block to verify {"round": 220370, "block": "8ddceef774063be626131c9009469ee25ad379423fa8af6e59bc9d24397675ea", "prev_block": "3d4993ea20c4b102f1dc90f05ff53719e0d26d938ca43f0ecdfe74b6953a8a08", "state_hash": "002ecbe4ff33d414c9900de4465701d1e89a296b56c0699108965958279d22fb", "weight": 0.5} 2025-11-10T03:07:31.783Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 220370, "randk": 1, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T03:07:31.783Z DEBUG statecache/statecache.go:131 statecache - commit {"block": "8ddceef774063be626131c9009469ee25ad379423fa8af6e59bc9d24397675ea", "bc_hits": 76, "bc_miss": 0, "sc_hits": 20104666, "sc_miss": 6214, "duration": "511.574µs"} 2025-11-10T03:07:31.782Z INFO miner/protocol_block.go:1316 generate block (assemble+update+sign) {"round": 220370, "block_size": 2, "reused_txns": 0, "reused_txns": 0, "time": "15.129704ms", "block": "8ddceef774063be626131c9009469ee25ad379423fa8af6e59bc9d24397675ea", "prev_block": "3d4993ea20c4b102f1dc90f05ff53719e0d26d938ca43f0ecdfe74b6953a8a08", "begin_state_hash": "f2bccc58a481a3cf89575a16db751a17cb4450f11caa1cef16f9544599292b98", "block_state_hash": "002ecbe4ff33d414c9900de4465701d1e89a296b56c0699108965958279d22fb", "computed_state_hash": "002ecbe4ff33d414c9900de4465701d1e89a296b56c0699108965958279d22fb", "changes": 9, "state_status": 4, "iteration_count": 0} 2025-11-10T03:07:31.782Z DEBUG miner/protocol_block.go:1305 generate block (assemble+update) {"round": 220370, "txns": 2, "time": "14.781811ms"} 2025-11-10T03:07:31.782Z DEBUG miner/protocol_block.go:1282 generate block (assemble) {"round": 220370, "txns": 2, "time": "14.71597ms"} 2025-11-10T03:07:31.781Z DEBUG chain/state.go:961 Updating nonce {"client": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "new_nonce": 112407} 2025-11-10T03:07:31.781Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T03:07:31.781Z INFO chain/state.go:533 SC executed {"client id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "block": "", "round": 220370, "prev_state_hash": "f2bccc58a481a3cf89575a16db751a17cb4450f11caa1cef16f9544599292b98", "txn_hash": "d6419ccf12988c1dec5a31accc71b374ed1bd1b14d5033dd7fd46a0c98ffaa36", "txn_nonce": 112407, "txn_func": "generate_challenge", "txn_status": 0, "txn_exec_time": "305.642µs", "begin client state": "5cec051baa3824710fc612d903ec9e38ec953b6bd34ce494026006bc778e7571", "current_root": "5cec051baa3824710fc612d903ec9e38ec953b6bd34ce494026006bc778e7571", "mpt_cache_hit": 9, "mpt_cache_miss": 0, "output": "OpenChallenges generated"} 2025-11-10T03:07:31.781Z INFO storagesc/challenge.go:1191 skipping generate challenge: empty blobber challenge partition 2025-11-10T03:07:31.781Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "eaf4195ad8a6c0bd8f90e9b28f4ba3b4938ddc60155952285997f669446bb502"} 2025-11-10T03:07:31.780Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T03:07:31.780Z DEBUG chain/protocol_view_change.go:424 [mvc] nonce, set nonce in getCurrentSelfNonce {"nonce": 112406} 2025-11-10T03:07:31.780Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T03:07:31.780Z DEBUG chain/protocol_view_change.go:431 [mvc] nonce, get current miner nonce {"minerId": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341"} 2025-11-10T03:07:31.779Z DEBUG chain/state.go:961 Updating nonce {"client": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "new_nonce": 112406} 2025-11-10T03:07:31.779Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T03:07:31.778Z INFO chain/state.go:533 SC executed {"client id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "block": "", "round": 220370, "prev_state_hash": "f2bccc58a481a3cf89575a16db751a17cb4450f11caa1cef16f9544599292b98", "txn_hash": "b36643e596d379e07cf39667736c41b409962a5eaaa04b5116d6d196b77aac82", "txn_nonce": 112406, "txn_func": "payFees", "txn_status": 0, "txn_exec_time": "7.40032ms", "begin client state": "f2bccc58a481a3cf89575a16db751a17cb4450f11caa1cef16f9544599292b98", "current_root": "c77209d7ed11560442ffe7fa74d3dad1ba1dd40ad3bf7e1ff0769600c6e9b787", "mpt_cache_hit": 43, "mpt_cache_miss": 0, "output": ""} 2025-11-10T03:07:31.778Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T03:07:31.778Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T03:07:31.777Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T03:07:31.777Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T03:07:31.772Z ERROR minersc/global_node.go:372 failed to get current magic block {"error": "value not present"} 2025-11-10T03:07:31.772Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "6dba10422e368813802877a85039d3985d96760ed844092319743fb3a76712d9d2208fe938b7465b9c5dc571053986cf8dbf3585fb36399f98ea569c42f50b76"} 2025-11-10T03:07:31.771Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "6dba10422e368813802877a85039d3985d96760ed844092319743fb3a76712d9b5e8a1650666fdd3a9de7855b6da63ab629b1701f23738477e2325f7ca2150ac"} 2025-11-10T03:07:31.771Z DEBUG minersc/fees.go:480 pay_fees, got miner id successfully {"miner id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "round": 220370, "block": ""} 2025-11-10T03:07:31.771Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T03:07:31.771Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T03:07:31.771Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T03:07:31.770Z DEBUG chain/protocol_view_change.go:424 [mvc] nonce, set nonce in getCurrentSelfNonce {"nonce": 112405} 2025-11-10T03:07:31.770Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\ufffdNPK\ufffdp\u001aX\u0005\ufffd\ufffd\n\ufffd\ufffd\ufffd\ufffd\u000ex\ufffd\u000f\ufffdq\ufffd\ufffd\ufffd\ufffd\ufffd&\ufffd#\ufffd%"} 2025-11-10T03:07:31.770Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "Ч\ufffd\u0000T\ufffd\u000f\ufffdF\u0007\u001b\ufffdG$+\ufffd%\ufffd\u0007^\ufffd\ufffd\ufffd\ufffdK>\u0013(\ufffd+\ufffd\ufffd"} 2025-11-10T03:07:31.770Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\ufffd\ufffd(\ufffd\ufffd\ufffdz\ufffd\u0014\ufffd\ufffd\ufffd\ufffd6\ufffdTTn\ufffdj^\u0002>\ufffd\u001bS᫫\ufffdAx"} 2025-11-10T03:07:31.770Z INFO miner/m_handler.go:242 Reject VRFShare: VRF is complete for this round {"vrfs_round_num": 220370, "vrfs_sender_index": 0, "vrfs_round_num": 220370} 2025-11-10T03:07:31.770Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\ufffd}\ufffd\ufffdc8\ufffd\ufffd\ufffd\ufffd\ufffd\u001e\n\ufffd\ufffd\ufffd]\ufffd\ufffd\u001d\u0002؅\ufffd\ufffd>\u0006g{Z\ufffd\ufffd"} 2025-11-10T03:07:31.770Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\ufffd\ufffd\ufffdX\ufffd\ufffd\ufffdωWZ\u0016\ufffdu\u001a\u0017\ufffdDP\ufffd\u001c\ufffd\u001c\ufffd\u0016\ufffdTE\ufffd)+\ufffd"} 2025-11-10T03:07:31.770Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T03:07:31.770Z DEBUG chain/protocol_view_change.go:431 [mvc] nonce, get current miner nonce {"minerId": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341"} 2025-11-10T03:07:31.770Z INFO memorystore/collection.go:65 Redis returned 0 rows after seclect 2025-11-10T03:07:31.770Z INFO miner/protocol_block.go:1112 generate block starting iteration {"round": 220370, "prev_block": "3d4993ea20c4b102f1dc90f05ff53719e0d26d938ca43f0ecdfe74b6953a8a08", "prev_state_hash": "f2bccc58a481a3cf89575a16db751a17cb4450f11caa1cef16f9544599292b98"} 2025-11-10T03:07:31.769Z DEBUG statecache/statecache.go:173 state cache - see gap {"block": "882f02d1a21ff33e5869b48b22636ae9e347097a5f2a60fe17bc24c417618cf2"} 2025-11-10T03:07:31.769Z DEBUG statecache/statecache.go:173 state cache - see gap {"block": "882f02d1a21ff33e5869b48b22636ae9e347097a5f2a60fe17bc24c417618cf2"} 2025-11-10T03:07:31.768Z DEBUG statecache/statecache.go:173 state cache - see gap {"block": "882f02d1a21ff33e5869b48b22636ae9e347097a5f2a60fe17bc24c417618cf2"} 2025-11-10T03:07:31.768Z INFO chain/entity.go:1721 delete blocks below round {"round": 220370, "below_round": 220317, "before": 1762743991, "total": 311, "count": 0} 2025-11-10T03:07:31.768Z DEBUG chain/protocol_round.go:334 finalize round - block has less than 3 confirmation 2025-11-10T03:07:31.768Z DEBUG chain/protocol_round.go:334 finalize round - block has less than 3 confirmation 2025-11-10T03:07:31.768Z INFO chain/protocol_round.go:326 finalize round - latest finalized round {"round": 220369, "lfb round": 220368, "lfb block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9"} 2025-11-10T03:07:31.768Z INFO chain/protocol_round.go:199 finalize round {"round": 220369, "plfb_round": 220366, "num_round_notarized": 1, "num_chain_notarized": 3} 2025-11-10T03:07:31.768Z INFO chain/entity.go:1721 delete blocks below round {"round": 220370, "below_round": 220316, "before": 1762743991, "total": 311, "count": 0} 2025-11-10T03:07:31.768Z DEBUG chain/protocol_round.go:334 finalize round - block has less than 3 confirmation 2025-11-10T03:07:31.768Z DEBUG chain/protocol_round.go:334 finalize round - block has less than 3 confirmation 2025-11-10T03:07:31.768Z DEBUG statecache/statecache.go:173 state cache - see gap {"block": "882f02d1a21ff33e5869b48b22636ae9e347097a5f2a60fe17bc24c417618cf2"} 2025-11-10T03:07:31.768Z INFO chain/protocol_round.go:402 finalize round - finalize block success {"round": 220366, "block": "590839da3aaffc06479d7d48fc9e523f958edee0826341a3e3e0f59b2532b1d2", "duration": "4.388196ms"} 2025-11-10T03:07:31.768Z DEBUG chain/worker.go:230 finalize block processed {"round": 220366, "duration": "4.338196ms"} 2025-11-10T03:07:31.768Z DEBUG chain/protocol_block.go:612 finalized block - done {"round": 220366, "block": "590839da3aaffc06479d7d48fc9e523f958edee0826341a3e3e0f59b2532b1d2", "duration": "4.151934ms"} 2025-11-10T03:07:31.768Z INFO chain/entity.go:2366 config has been updated successfully {"start of round": 220366} 2025-11-10T03:07:31.767Z DEBUG transaction/worker.go:253 [mvc] see no old txns {"clientID": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "nonce": 112404} 2025-11-10T03:07:31.767Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\ufffd\u001e\ufffd-7cq\u000e\ufffd\ufffdz\ufffdz\ufffd\ufffd\u0012\ufffdD\u001b\ufffdlj罦\ufffd\ufffd\u0003\ufffd'\ufffd}"} 2025-11-10T03:07:31.767Z INFO memorystore/collection.go:65 Redis returned 0 rows after seclect 2025-11-10T03:07:31.767Z DEBUG transaction/worker.go:221 [mvc] remove old nonce txns {"clientID": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "nonce": 112404} 2025-11-10T03:07:31.767Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\ufffd1f\u000b\ufffd\ufffdq[\ufffd\ufffd\ufffd`)x\ufffd\ufffdw\ufffdj:\ufffdH\u0001\ufffd⩲\ufffd\ufffd\ufffd\ufffd\ufffd"} 2025-11-10T03:07:31.767Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "-B\ufffd{\ufffdD\ufffdL\ufffd\ufffd\ufffd\ufffd\ufffd\u0011\u0006V\ufffd\u0008\u0011\ufffd+\ufffd\ufffd35\ufffd\u0019\ufffdL\ufffd+\ufffd"} 2025-11-10T03:07:31.767Z INFO miner/protocol_bls.go:481 DKG ThresholdNumSigReceived VRF is already completed. {"round": 220370} 2025-11-10T03:07:31.767Z INFO round/entity.go:675 add_vrf_share already at threshold. Returning false. 2025-11-10T03:07:31.767Z INFO miner/protocol_bls.go:430 verified vrf {"round": 220370, "node_id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "share": "1 3d303007d7fd91fef46f153038a3c0a3705608cd9419f8ea0346639e015ede 201937aaba266230a80bc5e6e08c866db780259365aff3df7767c4158947ad89", "from": "196b96df7631e00d339f9a25131927c4", "message": "22037004bad4a1951330a05"} 2025-11-10T03:07:31.767Z DEBUG chain/worker.go:443 BC is moving {"current_lfb_round": 220366, "last_round": 220365} 2025-11-10T03:07:31.767Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 220370, "randk": 1, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T03:07:31.767Z DEBUG miner/protocol_round.go:467 Setting LFMB round/hash for a block {"rn": 220370, "mc.crn": 220370, "rnoff": 220345, "nvc": 0, "r": 0, "h": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "b.lfmbr": 0, "b.lfmbh": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4"} 2025-11-10T03:07:31.767Z DEBUG chain/lfb_round_node.go:33 [mvc] store lfb {"round": 220366, "block": "590839da3aaffc06479d7d48fc9e523f958edee0826341a3e3e0f59b2532b1d2", "mb number": 1} 2025-11-10T03:07:31.767Z INFO transaction/worker.go:164 cleaning transactions {"collection": "collection.txn:0afc093ffb509f059c55478bc1a60351cef7b4e9c008a53a6cc8241ca8617dfe", "missing_count": 2, "txns": ["8f6469580f28d537079cebb29116ecd26f3e281c4d363b0a15970442fc0c4b9c", "b010f6816087cea864b94f2b30fc1afef3f6686c0fa17a34761c75407a34acca"], "past txns": []} 2025-11-10T03:07:31.767Z DEBUG chain/entity.go:2269 set lfb {"round": 220366, "block": "590839da3aaffc06479d7d48fc9e523f958edee0826341a3e3e0f59b2532b1d2", "state_computed": true} 2025-11-10T03:07:31.767Z DEBUG chain/state.go:128 finalize round - rebased current state db {"round": 220366, "block": "590839da3aaffc06479d7d48fc9e523f958edee0826341a3e3e0f59b2532b1d2", "state hash": "e0ffde27bfe8e4534fa2699958a648688216af4da56f67d45070bedaa036b89b"} 2025-11-10T03:07:31.767Z DEBUG util/mpt_nodedb.go:556 LevelNodeDB rebase db 2025-11-10T03:07:31.767Z INFO miner/protocol_round.go:830 Starting round verification {"round": 220370, "delta": "180ms"} 2025-11-10T03:07:31.767Z INFO round/entity.go:618 get miners by rank {"num_miners": 3, "round": 220370, "r.minerPerm": [0, 1, 2]} 2025-11-10T03:07:31.767Z INFO miner/protocol_round.go:340 *** TOC_FIX starting round block generation *** {"round": 220370, "index": 1, "rank": 1, "timeout_count": 0, "random_seed": 3260477833760333878, "lf_round": 220365} 2025-11-10T03:07:31.767Z DEBUG chain/protocol_block.go:424 finalize block - record dead nodes {"round": 220366, "block": "590839da3aaffc06479d7d48fc9e523f958edee0826341a3e3e0f59b2532b1d2", "num dead nodes": 16} 2025-11-10T03:07:31.767Z INFO memorystore/collection.go:65 Redis returned 0 rows after seclect 2025-11-10T03:07:31.767Z INFO miner/protocol_bls.go:591 Starting round with vrf {"round": 220370, "roundtimeout": 0, "rseed": 3260477833760333878, "prev_round": 220369, "Prev_rseed": 0} 2025-11-10T03:07:31.766Z DEBUG miner/protocol_bls.go:542 DKG computeRBO {"round": 220370} 2025-11-10T03:07:31.766Z INFO miner/protocol_bls.go:524 receive bls sign {"round": 220370, "group_signature": "1 2290c82fc18c383dede744408b4ee25b9d1d4402a363880e86c31b8da090616 1d7959d4607efa57a2504bed04654521775e8f651dba9edab8f4fc2a088b2bac", "rboOutput": "2d3f8b50a751e03696e0d815b41a6535c5127c167fee2998b9361578d5394a6d", "dkg_starting_round": 0, "dkg_mb_number": 1} 2025-11-10T03:07:31.766Z DEBUG transaction/worker.go:124 cleaning past transactions 2025-11-10T03:07:31.766Z DEBUG miner/round.go:238 Round clear - cancel verification 2025-11-10T03:07:31.766Z DEBUG miner/chain.go:313 delete txns {"txns": ["8f6469580f28d537079cebb29116ecd26f3e281c4d363b0a15970442fc0c4b9c", "b010f6816087cea864b94f2b30fc1afef3f6686c0fa17a34761c75407a34acca"]} 2025-11-10T03:07:31.766Z INFO miner/protocol_block.go:619 update finalized block (debug transaction) {"txn": "b010f6816087cea864b94f2b30fc1afef3f6686c0fa17a34761c75407a34acca", "block": "590839da3aaffc06479d7d48fc9e523f958edee0826341a3e3e0f59b2532b1d2"} 2025-11-10T03:07:31.766Z INFO miner/protocol_block.go:619 update finalized block (debug transaction) {"txn": "8f6469580f28d537079cebb29116ecd26f3e281c4d363b0a15970442fc0c4b9c", "block": "590839da3aaffc06479d7d48fc9e523f958edee0826341a3e3e0f59b2532b1d2"} 2025-11-10T03:07:31.766Z INFO miner/protocol_block.go:613 update finalized block {"round": 220366, "block": "590839da3aaffc06479d7d48fc9e523f958edee0826341a3e3e0f59b2532b1d2", "lf_round": 220365, "current_round": 220370, "weight": 1} 2025-11-10T03:07:31.766Z DEBUG chain/protocol_block.go:409 MPT state node stat - inc {"node num": -421009, "change num": 12, "delete num": 16} 2025-11-10T03:07:31.766Z DEBUG bls/dkg.go:396 dkg verify {"id": "196b96df7631e00d339f9a25131927c4", "key": "1 1f8c72cc3a6b74f6ad7528172b64afe3dc42ee1987495659fe2cf34e749caa7c 20957b4d25e7b5fb1e32d4e3b93e2b73dad7f118efb6dae28715e4ad627b0fff 14259a6ddf4b44c83c1389bd8ed1fc47c1b099c5986bb33923bbcbb25d30054a 2100bb7434dadde1a5ed8545748d0958955bcd21e06cf170f78dbda35a9e04b7", "msg": "22037004bad4a1951330a05", "sig": "1 3d303007d7fd91fef46f153038a3c0a3705608cd9419f8ea0346639e015ede 201937aaba266230a80bc5e6e08c866db780259365aff3df7767c4158947ad89"} 2025-11-10T03:07:31.766Z DEBUG miner/protocol_bls.go:496 VRF Hurray we've threshold BLS shares {"round": 220370, "round pointer": "0xc00b1c0630"} 2025-11-10T03:07:31.766Z DEBUG round/entity.go:684 add_vrf_share {"round": 220370, "round_vrf_num": 2, "threshold": 2} 2025-11-10T03:07:31.766Z INFO miner/protocol_bls.go:430 verified vrf {"round": 220370, "node_id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "share": "1 3d303007d7fd91fef46f153038a3c0a3705608cd9419f8ea0346639e015ede 201937aaba266230a80bc5e6e08c866db780259365aff3df7767c4158947ad89", "from": "196b96df7631e00d339f9a25131927c4", "message": "22037004bad4a1951330a05"} 2025-11-10T03:07:31.765Z INFO block/entity.go:1195 save state {"round": 220366, "block": "590839da3aaffc06479d7d48fc9e523f958edee0826341a3e3e0f59b2532b1d2", "block_size": 2, "changes": 12, "client_state": "e0ffde27bfe8e4534fa2699958a648688216af4da56f67d45070bedaa036b89b", "duration": "1.796545ms"} 2025-11-10T03:07:31.765Z DEBUG util/merkle_patricia_trie.go:272 MPT save changes success {"duration": "1.296231ms"} 2025-11-10T03:07:31.765Z DEBUG util/mpt_node_change.go:156 MPT - update changes done {"changes": 12} 2025-11-10T03:07:31.765Z DEBUG bls/dkg.go:396 dkg verify {"id": "196b96df7631e00d339f9a25131927c4", "key": "1 1f8c72cc3a6b74f6ad7528172b64afe3dc42ee1987495659fe2cf34e749caa7c 20957b4d25e7b5fb1e32d4e3b93e2b73dad7f118efb6dae28715e4ad627b0fff 14259a6ddf4b44c83c1389bd8ed1fc47c1b099c5986bb33923bbcbb25d30054a 2100bb7434dadde1a5ed8545748d0958955bcd21e06cf170f78dbda35a9e04b7", "msg": "22037004bad4a1951330a05", "sig": "1 3d303007d7fd91fef46f153038a3c0a3705608cd9419f8ea0346639e015ede 201937aaba266230a80bc5e6e08c866db780259365aff3df7767c4158947ad89"} 2025-11-10T03:07:31.765Z DEBUG round/entity.go:684 add_vrf_share {"round": 220370, "round_vrf_num": 1, "threshold": 2} 2025-11-10T03:07:31.765Z INFO miner/protocol_bls.go:430 verified vrf {"round": 220370, "node_id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "share": "1 19dccfc30b3b5408f51bd81ac4cbd1127899c0360ebfda6a0735ad13d7c74921 b023249b7fce176036ff2dd6ad1527a33d9053698e1a074bc2e3904e367357d", "from": "18f9a15b9551f8552a19cf4750ef14bf", "message": "22037004bad4a1951330a05"} 2025-11-10T03:07:31.764Z DEBUG util/mpt_node_change.go:150 MPT - update changes {"changes": 12} 2025-11-10T03:07:31.764Z INFO miner/protocol_bls.go:265 BLS sign VRF share calculated for {"round": 220370, "round_timeout": 0, "prev_rseed": 5453096196412475909, "prev round vrf random seed": "4bad4a1951330a05", "bls_msg": "22037004bad4a1951330a05"} 2025-11-10T03:07:31.764Z DEBUG bls/dkg.go:396 dkg verify {"id": "18f9a15b9551f8552a19cf4750ef14bf", "key": "1 15981a99909f8d701bca846be62c295e8958436831d3087ded78a1719a92f9a9 1bc96c0fea12a9ee4451600417977d1e987b252b469ea7c7be9d40e681fceff4 164089f6538d2b42ac3b37af7bc35e2550212af1e8ccedfeec4bde4f472dd384 aa502eaa78fb0cc02bd92538e258b55b1495cdc393205378d4ead83eb106f33", "msg": "22037004bad4a1951330a05", "sig": "1 19dccfc30b3b5408f51bd81ac4cbd1127899c0360ebfda6a0735ad13d7c74921 b023249b7fce176036ff2dd6ad1527a33d9053698e1a074bc2e3904e367357d"} 2025-11-10T03:07:31.764Z INFO miner/protocol_bls.go:364 DKG AddVRFShare {"round": 220370, "round_vrf_num": 0, "threshold": 2, "sender": 1, "round_timeout_count": 0, "vrf_timeout_count": 0, "vrf_share": "1 3d303007d7fd91fef46f153038a3c0a3705608cd9419f8ea0346639e015ede 201937aaba266230a80bc5e6e08c866db780259365aff3df7767c4158947ad89"} 2025-11-10T03:07:31.764Z INFO miner/protocol_round.go:78 add_my_vrf_share {"round": 220370, "round_timeout": 0, "dkg_starting_round": 0, "dkg_mb_number": 1, "pr_seed": 5453096196412475909, "pr_vrf_seed": "4bad4a1951330a05", "share": "1 3d303007d7fd91fef46f153038a3c0a3705608cd9419f8ea0346639e015ede 201937aaba266230a80bc5e6e08c866db780259365aff3df7767c4158947ad89"} 2025-11-10T03:07:31.764Z DEBUG miner/protocol_bls.go:305 get_bls_share {"round": 220370, "rtc": 0, "dkg_pi": "1 1f8c72cc3a6b74f6ad7528172b64afe3dc42ee1987495659fe2cf34e749caa7c 20957b4d25e7b5fb1e32d4e3b93e2b73dad7f118efb6dae28715e4ad627b0fff 14259a6ddf4b44c83c1389bd8ed1fc47c1b099c5986bb33923bbcbb25d30054a 2100bb7434dadde1a5ed8545748d0958955bcd21e06cf170f78dbda35a9e04b7", "dkg_sr": 0, "mb_sr": 0, "share": "1 3d303007d7fd91fef46f153038a3c0a3705608cd9419f8ea0346639e015ede 201937aaba266230a80bc5e6e08c866db780259365aff3df7767c4158947ad89"} 2025-11-10T03:07:31.764Z INFO miner/protocol_bls.go:265 BLS sign VRF share calculated for {"round": 220370, "round_timeout": 0, "prev_rseed": 5453096196412475909, "prev round vrf random seed": "4bad4a1951330a05", "bls_msg": "22037004bad4a1951330a05"} 2025-11-10T03:07:31.764Z INFO miner/protocol_bls.go:364 DKG AddVRFShare {"round": 220370, "round_vrf_num": 0, "threshold": 2, "sender": 1, "round_timeout_count": 0, "vrf_timeout_count": 0, "vrf_share": "1 3d303007d7fd91fef46f153038a3c0a3705608cd9419f8ea0346639e015ede 201937aaba266230a80bc5e6e08c866db780259365aff3df7767c4158947ad89"} 2025-11-10T03:07:31.764Z INFO miner/protocol_round.go:78 add_my_vrf_share {"round": 220370, "round_timeout": 0, "dkg_starting_round": 0, "dkg_mb_number": 1, "pr_seed": 5453096196412475909, "pr_vrf_seed": "4bad4a1951330a05", "share": "1 3d303007d7fd91fef46f153038a3c0a3705608cd9419f8ea0346639e015ede 201937aaba266230a80bc5e6e08c866db780259365aff3df7767c4158947ad89"} 2025-11-10T03:07:31.764Z DEBUG miner/protocol_bls.go:305 get_bls_share {"round": 220370, "rtc": 0, "dkg_pi": "1 1f8c72cc3a6b74f6ad7528172b64afe3dc42ee1987495659fe2cf34e749caa7c 20957b4d25e7b5fb1e32d4e3b93e2b73dad7f118efb6dae28715e4ad627b0fff 14259a6ddf4b44c83c1389bd8ed1fc47c1b099c5986bb33923bbcbb25d30054a 2100bb7434dadde1a5ed8545748d0958955bcd21e06cf170f78dbda35a9e04b7", "dkg_sr": 0, "mb_sr": 0, "share": "1 3d303007d7fd91fef46f153038a3c0a3705608cd9419f8ea0346639e015ede 201937aaba266230a80bc5e6e08c866db780259365aff3df7767c4158947ad89"} 2025-11-10T03:07:31.764Z INFO round/entity.go:618 get miners by rank {"num_miners": 3, "round": 220366, "r.minerPerm": [1, 2, 0]} 2025-11-10T03:07:31.764Z INFO chain/protocol_block.go:363 finalize block -- round {"round": {"number":220366,"round_random_seed":8187067796898099423,"block_hash":"590839da3aaffc06479d7d48fc9e523f958edee0826341a3e3e0f59b2532b1d2","vrf_output":"719e4ec8ca26b0df7e885cbac94cb623f7ae87cf21a093f24d2e4fb5a54cf764"}, "block": "590839da3aaffc06479d7d48fc9e523f958edee0826341a3e3e0f59b2532b1d2"} 2025-11-10T03:07:31.764Z INFO chain/protocol_block.go:328 finalize block {"round": 220366, "current_round": 220370, "lf_round": 220365, "hash": "590839da3aaffc06479d7d48fc9e523f958edee0826341a3e3e0f59b2532b1d2", "round_rank": 0, "state": 7} 2025-11-10T03:07:31.763Z DEBUG chain/worker.go:262 start to finalize block {"round": 220366, "block": "590839da3aaffc06479d7d48fc9e523f958edee0826341a3e3e0f59b2532b1d2", "prev block": "d1908c8dca3d93b96877cd4a747d69891898951bc599b2a584e58c5907e29b69"} 2025-11-10T03:07:31.763Z DEBUG bls/dkg.go:356 dkg sign {"key": "1ef4cd5ccbeb2dfce1247caae9b2222f43537288563d8624eeb7f5102005c109", "pi": "1 1f8c72cc3a6b74f6ad7528172b64afe3dc42ee1987495659fe2cf34e749caa7c 20957b4d25e7b5fb1e32d4e3b93e2b73dad7f118efb6dae28715e4ad627b0fff 14259a6ddf4b44c83c1389bd8ed1fc47c1b099c5986bb33923bbcbb25d30054a 2100bb7434dadde1a5ed8545748d0958955bcd21e06cf170f78dbda35a9e04b7"} 2025-11-10T03:07:31.763Z DEBUG miner/protocol_bls.go:293 Sign msg with dkg {"msg": "22037004bad4a1951330a05", "round": 220370, "dkg starting round": 0} 2025-11-10T03:07:31.763Z DEBUG chain/protocol_round.go:160 finalize round {"round": 220369, "lf_round": 220365} 2025-11-10T03:07:31.763Z INFO chain/protocol_round.go:359 finalize round {"round": 220366, "lfb round": 220368, "block": "590839da3aaffc06479d7d48fc9e523f958edee0826341a3e3e0f59b2532b1d2"} 2025-11-10T03:07:31.763Z INFO miner/protocol_bls.go:265 BLS sign VRF share calculated for {"round": 220370, "round_timeout": 0, "prev_rseed": 5453096196412475909, "prev round vrf random seed": "4bad4a1951330a05", "bls_msg": "22037004bad4a1951330a05"} 2025-11-10T03:07:31.763Z DEBUG chain/protocol_round.go:156 finalize_round: already finalizing {"round": 220369} 2025-11-10T03:07:31.763Z INFO chain/protocol_round.go:326 finalize round - latest finalized round {"round": 220369, "lfb round": 220368, "lfb block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9"} 2025-11-10T03:07:31.763Z INFO miner/protocol_bls.go:283 DKG getBlsShare {"Round Number": 220370} 2025-11-10T03:07:31.763Z INFO miner/protocol_round.go:244 StartNextRound - add VRF {"round": 220370} 2025-11-10T03:07:31.763Z INFO chain/protocol_round.go:199 finalize round {"round": 220369, "plfb_round": 220365, "num_round_notarized": 1, "num_chain_notarized": 3} 2025-11-10T03:07:31.763Z INFO miner/round.go:40 Try to cancel block generation that have not been started yet {"round": 220369} 2025-11-10T03:07:31.763Z DEBUG bls/dkg.go:356 dkg sign {"key": "1ef4cd5ccbeb2dfce1247caae9b2222f43537288563d8624eeb7f5102005c109", "pi": "1 1f8c72cc3a6b74f6ad7528172b64afe3dc42ee1987495659fe2cf34e749caa7c 20957b4d25e7b5fb1e32d4e3b93e2b73dad7f118efb6dae28715e4ad627b0fff 14259a6ddf4b44c83c1389bd8ed1fc47c1b099c5986bb33923bbcbb25d30054a 2100bb7434dadde1a5ed8545748d0958955bcd21e06cf170f78dbda35a9e04b7"} 2025-11-10T03:07:31.763Z DEBUG miner/protocol_bls.go:293 Sign msg with dkg {"msg": "22037004bad4a1951330a05", "round": 220370, "dkg starting round": 0} 2025-11-10T03:07:31.763Z DEBUG chain/protocol_round.go:160 finalize round {"round": 220369, "lf_round": 220365} 2025-11-10T03:07:31.763Z INFO miner/protocol_bls.go:265 BLS sign VRF share calculated for {"round": 220370, "round_timeout": 0, "prev_rseed": 5453096196412475909, "prev round vrf random seed": "4bad4a1951330a05", "bls_msg": "22037004bad4a1951330a05"} 2025-11-10T03:07:31.763Z DEBUG miner/protocol_round.go:210 finalizedRound - cancel round verification {"round": 220369} 2025-11-10T03:07:31.763Z INFO miner/protocol_bls.go:283 DKG getBlsShare {"Round Number": 220370} 2025-11-10T03:07:31.763Z INFO miner/protocol_round.go:244 StartNextRound - add VRF {"round": 220370} 2025-11-10T03:07:31.763Z INFO miner/round.go:40 Try to cancel block generation that have not been started yet {"round": 220369} 2025-11-10T03:07:31.763Z DEBUG miner/protocol_round.go:210 finalizedRound - cancel round verification {"round": 220369} 2025-11-10T03:07:31.763Z INFO chain/entity.go:2016 Moving to the next round {"next_round": 220370} 2025-11-10T03:07:31.763Z DEBUG miner/protocol_round.go:154 [wait not ahead] [2] not ahead, can move on {"round": 220369, "lfb tk round": 220365} 2025-11-10T03:07:31.763Z DEBUG miner/protocol_round.go:991 verification_complete {"top_verified_rank": 0} 2025-11-10T03:07:31.763Z DEBUG miner/protocol_round.go:154 [wait not ahead] [2] not ahead, can move on {"round": 220369, "lfb tk round": 220365} 2025-11-10T03:07:31.763Z DEBUG miner/protocol_round.go:123 [wait not ahead] 2025-11-10T03:07:31.763Z INFO miner/protocol_round.go:986 verification_complete {"round": 220369, "verified_blocks": 0} 2025-11-10T03:07:31.763Z INFO miner/protocol_receive.go:370 process notarization success {"round": 220369, "block": "3d4993ea20c4b102f1dc90f05ff53719e0d26d938ca43f0ecdfe74b6953a8a08", "duration": "1.780435ms"} 2025-11-10T03:07:31.763Z INFO miner/round.go:40 Try to cancel block generation that have not been started yet {"round": 220369} 2025-11-10T03:07:31.763Z INFO miner/protocol_receive.go:456 process notarization - start next round {"new round": 220370} 2025-11-10T03:07:31.763Z DEBUG miner/protocol_round.go:123 [wait not ahead] 2025-11-10T03:07:31.763Z DEBUG round/entity.go:311 add notarized block - block already exist, merge tickets {"round": 220369, "block": "3d4993ea20c4b102f1dc90f05ff53719e0d26d938ca43f0ecdfe74b6953a8a08"} 2025-11-10T03:07:31.763Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 220369, "randk": 0, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T03:07:31.763Z INFO chain/entity.go:1571 Adding a notarized block for current round {"Round": 220369} 2025-11-10T03:07:31.763Z INFO miner/round.go:44 Cancelling block generation {"round": 220369} 2025-11-10T03:07:31.763Z INFO miner/round.go:230 Cancelling verification {"round": 220369} 2025-11-10T03:07:31.763Z INFO miner/protocol_receive.go:456 process notarization - start next round {"new round": 220370} 2025-11-10T03:07:31.763Z DEBUG miner/protocol_round.go:1149 check block notarization - block notarized {"round": 220369, "block": "3d4993ea20c4b102f1dc90f05ff53719e0d26d938ca43f0ecdfe74b6953a8a08"} 2025-11-10T03:07:31.763Z DEBUG round/entity.go:344 reached notarization {"round": 220369} 2025-11-10T03:07:31.763Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 220369, "randk": 0, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T03:07:31.763Z INFO chain/entity.go:1571 Adding a notarized block for current round {"Round": 220369} 2025-11-10T03:07:31.762Z INFO chain/protocol_block.go:319 reached notarization - merging tickets {"round": 220369, "current_round": 220369, "block": "3d4993ea20c4b102f1dc90f05ff53719e0d26d938ca43f0ecdfe74b6953a8a08", "tickets_num": 2} 2025-11-10T03:07:31.762Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"vrf_share","value":"VRF Share"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "duration": "104.261µs"} 2025-11-10T03:07:31.762Z DEBUG miner/protocol_receive.go:33 received VRF share for the future round, caching it {"current_round": 220369, "vrf_share_round": 220370} 2025-11-10T03:07:31.762Z DEBUG miner/protocol_receive.go:26 handle vrf share {"round": 220370, "vrf_timeout_count": 0, "sender_index": 0} 2025-11-10T03:07:31.762Z DEBUG miner/worker.go:53 message {"msg": {"code":"vrf_share","value":"VRF Share"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71"} 2025-11-10T03:07:31.761Z DEBUG miner/protocol_receive.go:428 process notarization - merge notarization block {"round": 220369, "block": "3d4993ea20c4b102f1dc90f05ff53719e0d26d938ca43f0ecdfe74b6953a8a08"} 2025-11-10T03:07:31.761Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"notarization","value":"Notarization"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "duration": "50.61µs"} 2025-11-10T03:07:31.761Z DEBUG miner/worker.go:53 message {"msg": {"code":"notarization","value":"Notarization"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71"} 2025-11-10T03:07:31.747Z DEBUG miner/protocol_round.go:943 verifyAndSend - finished successfully {"round": 220369, "block": "3d4993ea20c4b102f1dc90f05ff53719e0d26d938ca43f0ecdfe74b6953a8a08"} 2025-11-10T03:07:31.747Z INFO miner/protocol_round.go:1127 checkBlockNotarization -- block is not Notarized. Returning {"round": 220369, "block hash": "3d4993ea20c4b102f1dc90f05ff53719e0d26d938ca43f0ecdfe74b6953a8a08"} 2025-11-10T03:07:31.747Z INFO chain/protocol_block.go:225 not reached notarization {"mb_sr": 0, "active_miners": 3, "threshold": 2, "num_signatures": 1, "current_round": 220369, "round": 220369} 2025-11-10T03:07:31.746Z INFO miner/protocol_round.go:920 verifyAndSend - sending verification ticket {"round": 220369, "block": "3d4993ea20c4b102f1dc90f05ff53719e0d26d938ca43f0ecdfe74b6953a8a08", "block_rank": 0, "RRS": 5453096196412475909} 2025-11-10T03:07:31.746Z DEBUG miner/protocol_round.go:1040 verify round block {"round": 220369, "block": "3d4993ea20c4b102f1dc90f05ff53719e0d26d938ca43f0ecdfe74b6953a8a08"} 2025-11-10T03:07:31.746Z DEBUG miner/protocol_round.go:865 verifyAndSend - started {"block": "3d4993ea20c4b102f1dc90f05ff53719e0d26d938ca43f0ecdfe74b6953a8a08"} 2025-11-10T03:07:31.746Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 220369, "randk": 1, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T03:07:31.746Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 220369, "randk": 0, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T03:07:31.746Z INFO miner/protocol_round.go:951 Started main verification loop {"round": 220369} 2025-11-10T03:07:31.744Z DEBUG chain/protocol_lfb_ticket.go:386 update lfb ticket - ticket.Round <= latest.Round {"ticket.Round": 220365, "latest.Round": 220365} 2025-11-10T03:07:31.733Z DEBUG chain/protocol_lfb_ticket.go:386 update lfb ticket - ticket.Round <= latest.Round {"ticket.Round": 220365, "latest.Round": 220365} 2025-11-10T03:07:31.703Z DEBUG chain/entity.go:440 process block, no block in buffer {"current round": 220369} 2025-11-10T03:07:31.602Z DEBUG chain/entity.go:440 process block, no block in buffer {"current round": 220369} 2025-11-10T03:07:31.580Z DEBUG miner/protocol_round.go:1028 verify block - pending {"round": 220369, "block": "7dc516f2e6a9de6df440592a61c234b9afd3e5d2123595b1874b108d0f2d2e9c"} 2025-11-10T03:07:31.580Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 220369, "randk": 1, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T03:07:31.580Z DEBUG miner/protocol_round.go:759 update prev block notarization, already notarized {"round": 220368, "block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9"} 2025-11-10T03:07:31.580Z DEBUG miner/protocol_receive.go:130 verify block processed {"round": 220369, "block": "7dc516f2e6a9de6df440592a61c234b9afd3e5d2123595b1874b108d0f2d2e9c"} 2025-11-10T03:07:31.580Z DEBUG miner/round.go:143 Adding block to verifyChannel {"round": 220369, "block hash": "7dc516f2e6a9de6df440592a61c234b9afd3e5d2123595b1874b108d0f2d2e9c", "magic block": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "magic block round": 0} 2025-11-10T03:07:31.580Z INFO miner/protocol_round.go:803 adding block to verify {"round": 220369, "block": "7dc516f2e6a9de6df440592a61c234b9afd3e5d2123595b1874b108d0f2d2e9c", "prev_block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9", "state_hash": "1e550ac54dad7a33cc205271ecd8c4960b827160c53292656859b7c668af0a97", "weight": 1} 2025-11-10T03:07:31.580Z INFO miner/protocol_round.go:613 handle verify block - added block for ticket verification {"round": 220369, "block": "7dc516f2e6a9de6df440592a61c234b9afd3e5d2123595b1874b108d0f2d2e9c", "magic block": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "magic block round": 0} 2025-11-10T03:07:31.580Z INFO chain/protocol_block.go:225 not reached notarization {"mb_sr": 0, "active_miners": 3, "threshold": 2, "num_signatures": 0, "current_round": 220369, "round": 220369} 2025-11-10T03:07:31.580Z DEBUG miner/protocol_receive.go:169 verify block {"round": 220369, "block": "7dc516f2e6a9de6df440592a61c234b9afd3e5d2123595b1874b108d0f2d2e9c"} 2025-11-10T03:07:31.580Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"verify_block","value":"Verify Block"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "duration": "28.57µs"} 2025-11-10T03:07:31.579Z DEBUG miner/worker.go:53 message {"msg": {"code":"verify_block","value":"Verify Block"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71"} 2025-11-10T03:07:31.579Z DEBUG miner/protocol_round.go:1028 verify block - pending {"round": 220369, "block": "3d4993ea20c4b102f1dc90f05ff53719e0d26d938ca43f0ecdfe74b6953a8a08"} 2025-11-10T03:07:31.579Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 220369, "randk": 0, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T03:07:31.579Z DEBUG miner/round.go:143 Adding block to verifyChannel {"round": 220369, "block hash": "3d4993ea20c4b102f1dc90f05ff53719e0d26d938ca43f0ecdfe74b6953a8a08", "magic block": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "magic block round": 0} 2025-11-10T03:07:31.579Z INFO miner/protocol_round.go:803 adding block to verify {"round": 220369, "block": "3d4993ea20c4b102f1dc90f05ff53719e0d26d938ca43f0ecdfe74b6953a8a08", "prev_block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9", "state_hash": "f2bccc58a481a3cf89575a16db751a17cb4450f11caa1cef16f9544599292b98", "weight": 1} 2025-11-10T03:07:31.579Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 220369, "randk": 0, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T03:07:31.579Z DEBUG statecache/statecache.go:131 statecache - commit {"block": "3d4993ea20c4b102f1dc90f05ff53719e0d26d938ca43f0ecdfe74b6953a8a08", "bc_hits": 55, "bc_miss": 0, "sc_hits": 20104590, "sc_miss": 6214, "duration": "390.553µs"} 2025-11-10T03:07:31.578Z INFO miner/protocol_block.go:1316 generate block (assemble+update+sign) {"round": 220369, "block_size": 1, "reused_txns": 0, "reused_txns": 0, "time": "12.18207ms", "block": "3d4993ea20c4b102f1dc90f05ff53719e0d26d938ca43f0ecdfe74b6953a8a08", "prev_block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9", "begin_state_hash": "5ea97bb785ede9d7c5768c8aae547ddce98afeb752aa443ed99f3916101dd605", "block_state_hash": "f2bccc58a481a3cf89575a16db751a17cb4450f11caa1cef16f9544599292b98", "computed_state_hash": "f2bccc58a481a3cf89575a16db751a17cb4450f11caa1cef16f9544599292b98", "changes": 9, "state_status": 4, "iteration_count": 0} 2025-11-10T03:07:31.578Z DEBUG miner/protocol_block.go:1305 generate block (assemble+update) {"round": 220369, "txns": 1, "time": "11.973878ms"} 2025-11-10T03:07:31.578Z DEBUG miner/protocol_block.go:1282 generate block (assemble) {"round": 220369, "txns": 1, "time": "11.932838ms"} 2025-11-10T03:07:31.577Z DEBUG chain/state.go:961 Updating nonce {"client": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "new_nonce": 112405} 2025-11-10T03:07:31.576Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T03:07:31.576Z INFO chain/state.go:533 SC executed {"client id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "block": "", "round": 220369, "prev_state_hash": "5ea97bb785ede9d7c5768c8aae547ddce98afeb752aa443ed99f3916101dd605", "txn_hash": "f242e34522bd6de6ebaa5ab9f52fcf1ad62af35bf76cfeff6314c762cdf424a9", "txn_nonce": 112405, "txn_func": "payFees", "txn_status": 0, "txn_exec_time": "7.560342ms", "begin client state": "5ea97bb785ede9d7c5768c8aae547ddce98afeb752aa443ed99f3916101dd605", "current_root": "36552e25db4e42b1f4757cf6ca74a12bdba092e0714c98523e67bfa14f8b8a33", "mpt_cache_hit": 43, "mpt_cache_miss": 0, "output": ""} 2025-11-10T03:07:31.575Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T03:07:31.575Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T03:07:31.574Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T03:07:31.574Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T03:07:31.571Z INFO miner/m_handler.go:242 Reject VRFShare: VRF is complete for this round {"vrfs_round_num": 220369, "vrfs_sender_index": 0, "vrfs_round_num": 220369} 2025-11-10T03:07:31.569Z ERROR minersc/global_node.go:372 failed to get current magic block {"error": "value not present"} 2025-11-10T03:07:31.569Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "6dba10422e368813802877a85039d3985d96760ed844092319743fb3a76712d9d2208fe938b7465b9c5dc571053986cf8dbf3585fb36399f98ea569c42f50b76"} 2025-11-10T03:07:31.569Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "6dba10422e368813802877a85039d3985d96760ed844092319743fb3a76712d9b5e8a1650666fdd3a9de7855b6da63ab629b1701f23738477e2325f7ca2150ac"} 2025-11-10T03:07:31.569Z DEBUG minersc/fees.go:480 pay_fees, got miner id successfully {"miner id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "round": 220369, "block": ""} 2025-11-10T03:07:31.568Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T03:07:31.568Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T03:07:31.568Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T03:07:31.568Z DEBUG chain/protocol_view_change.go:424 [mvc] nonce, set nonce in getCurrentSelfNonce {"nonce": 112404} 2025-11-10T03:07:31.568Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "-B\ufffd{\ufffdD\ufffdL\ufffd\ufffd\ufffd\ufffd\ufffd\u0011\u0006V\ufffd\u0008\u0011\ufffd+\ufffd\ufffd35\ufffd\u0019\ufffdL\ufffd+\ufffd"} 2025-11-10T03:07:31.568Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\ufffd\ufffd\ufffd\u0016\ufffdu\ufffd\u000e\u0010X\ufffd%P\ufffd3f\u0000-a\ufffds\ufffd\ufffdba/\ufffd}\u000b3;,"} 2025-11-10T03:07:31.568Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\ufffd\ufffd(\ufffd\ufffd\ufffdz\ufffd\u0014\ufffd\ufffd\ufffd\ufffd6\ufffdTTn\ufffdj^\u0002>\ufffd\u001bS᫫\ufffdAx"} 2025-11-10T03:07:31.568Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\ufffd}\ufffd\ufffdc8\ufffd\ufffd\ufffd\ufffd\ufffd\u001e\n\ufffd\ufffd\ufffd]\ufffd\ufffd\u001d\u0002؅\ufffd\ufffd>\u0006g{Z\ufffd\ufffd"} 2025-11-10T03:07:31.568Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "^\ufffd{\ufffd\ufffd\ufffd\ufffd\ufffd\ufffdv\ufffd\ufffd\ufffdT}\ufffd\ufffd\ufffd\ufffd\ufffdR\ufffdD>ٟ9\u0016\u0010\u001d\ufffd\u0005"} 2025-11-10T03:07:31.568Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T03:07:31.568Z DEBUG chain/protocol_view_change.go:431 [mvc] nonce, get current miner nonce {"minerId": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341"} 2025-11-10T03:07:31.568Z INFO memorystore/collection.go:65 Redis returned 0 rows after seclect 2025-11-10T03:07:31.567Z INFO miner/protocol_block.go:1112 generate block starting iteration {"round": 220369, "prev_block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9", "prev_state_hash": "5ea97bb785ede9d7c5768c8aae547ddce98afeb752aa443ed99f3916101dd605"} 2025-11-10T03:07:31.567Z DEBUG statecache/statecache.go:173 state cache - see gap {"block": "882f02d1a21ff33e5869b48b22636ae9e347097a5f2a60fe17bc24c417618cf2"} 2025-11-10T03:07:31.566Z DEBUG statecache/statecache.go:173 state cache - see gap {"block": "882f02d1a21ff33e5869b48b22636ae9e347097a5f2a60fe17bc24c417618cf2"} 2025-11-10T03:07:31.566Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 220369, "randk": 0, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T03:07:31.566Z DEBUG miner/protocol_round.go:467 Setting LFMB round/hash for a block {"rn": 220369, "mc.crn": 220369, "rnoff": 220344, "nvc": 0, "r": 0, "h": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "b.lfmbr": 0, "b.lfmbh": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4"} 2025-11-10T03:07:31.566Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"vrf_share","value":"VRF Share"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "duration": "1.683883ms"} 2025-11-10T03:07:31.566Z INFO miner/protocol_round.go:830 Starting round verification {"round": 220369, "delta": "180ms"} 2025-11-10T03:07:31.566Z INFO round/entity.go:618 get miners by rank {"num_miners": 3, "round": 220369, "r.minerPerm": [1, 0, 2]} 2025-11-10T03:07:31.566Z INFO miner/protocol_round.go:340 *** TOC_FIX starting round block generation *** {"round": 220369, "index": 1, "rank": 0, "timeout_count": 0, "random_seed": 5453096196412475909, "lf_round": 220365} 2025-11-10T03:07:31.566Z INFO miner/protocol_bls.go:591 Starting round with vrf {"round": 220369, "roundtimeout": 0, "rseed": 5453096196412475909, "prev_round": 220368, "Prev_rseed": 0} 2025-11-10T03:07:31.566Z DEBUG miner/protocol_bls.go:542 DKG computeRBO {"round": 220369} 2025-11-10T03:07:31.566Z INFO miner/protocol_bls.go:524 receive bls sign {"round": 220369, "group_signature": "1 17590ee167f194060b09ead775ba4c1fcfddc574e5edd9fa6f101a05c7207e3 82fd4ada27926f0f72236dd4a52ce1e466064a1d30c68a7500e254ade329734", "rboOutput": "4bad4a1951330a052015c6593cc957213416b2e47f507e60a489f00053215e93", "dkg_starting_round": 0, "dkg_mb_number": 1} 2025-11-10T03:07:31.565Z DEBUG miner/protocol_bls.go:496 VRF Hurray we've threshold BLS shares {"round": 220369, "round pointer": "0xc018edf680"} 2025-11-10T03:07:31.565Z DEBUG round/entity.go:684 add_vrf_share {"round": 220369, "round_vrf_num": 2, "threshold": 2} 2025-11-10T03:07:31.565Z INFO miner/protocol_bls.go:430 verified vrf {"round": 220369, "node_id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "share": "1 b6f209b81de6b40b8c47e62238bcbf216f4c680f39f7c12782014107620ddce 743d64649cdf6bc84532207e279a65a334e5576504ea62741938b9c74540370", "from": "18f9a15b9551f8552a19cf4750ef14bf", "message": "2203690a3ee2bd0a6a5df3"} 2025-11-10T03:07:31.564Z DEBUG bls/dkg.go:396 dkg verify {"id": "18f9a15b9551f8552a19cf4750ef14bf", "key": "1 15981a99909f8d701bca846be62c295e8958436831d3087ded78a1719a92f9a9 1bc96c0fea12a9ee4451600417977d1e987b252b469ea7c7be9d40e681fceff4 164089f6538d2b42ac3b37af7bc35e2550212af1e8ccedfeec4bde4f472dd384 aa502eaa78fb0cc02bd92538e258b55b1495cdc393205378d4ead83eb106f33", "msg": "2203690a3ee2bd0a6a5df3", "sig": "1 b6f209b81de6b40b8c47e62238bcbf216f4c680f39f7c12782014107620ddce 743d64649cdf6bc84532207e279a65a334e5576504ea62741938b9c74540370"} 2025-11-10T03:07:31.564Z INFO miner/protocol_bls.go:265 BLS sign VRF share calculated for {"round": 220369, "round_timeout": 0, "prev_rseed": 738276690486779379, "prev round vrf random seed": "a3ee2bd0a6a5df3", "bls_msg": "2203690a3ee2bd0a6a5df3"} 2025-11-10T03:07:31.564Z INFO miner/protocol_bls.go:364 DKG AddVRFShare {"round": 220369, "round_vrf_num": 1, "threshold": 2, "sender": 0, "round_timeout_count": 0, "vrf_timeout_count": 0, "vrf_share": "1 b6f209b81de6b40b8c47e62238bcbf216f4c680f39f7c12782014107620ddce 743d64649cdf6bc84532207e279a65a334e5576504ea62741938b9c74540370"} 2025-11-10T03:07:31.564Z DEBUG miner/protocol_receive.go:26 handle vrf share {"round": 220369, "vrf_timeout_count": 0, "sender_index": 0} 2025-11-10T03:07:31.564Z DEBUG miner/worker.go:53 message {"msg": {"code":"vrf_share","value":"VRF Share"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71"} 2025-11-10T03:07:31.563Z INFO chain/entity.go:1721 delete blocks below round {"round": 220369, "below_round": 220315, "before": 1762743991, "total": 310, "count": 0} 2025-11-10T03:07:31.563Z DEBUG chain/protocol_round.go:334 finalize round - block has less than 3 confirmation 2025-11-10T03:07:31.563Z DEBUG chain/protocol_round.go:334 finalize round - block has less than 3 confirmation 2025-11-10T03:07:31.563Z INFO chain/protocol_round.go:402 finalize round - finalize block success {"round": 220365, "block": "d1908c8dca3d93b96877cd4a747d69891898951bc599b2a584e58c5907e29b69", "duration": "3.300167ms"} 2025-11-10T03:07:31.563Z DEBUG chain/worker.go:230 finalize block processed {"round": 220365, "duration": "3.256667ms"} 2025-11-10T03:07:31.563Z DEBUG chain/protocol_block.go:612 finalized block - done {"round": 220365, "block": "d1908c8dca3d93b96877cd4a747d69891898951bc599b2a584e58c5907e29b69", "duration": "3.162966ms"} 2025-11-10T03:07:31.563Z INFO chain/entity.go:2366 config has been updated successfully {"start of round": 220365} 2025-11-10T03:07:31.562Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\ufffd\u001e\ufffd-7cq\u000e\ufffd\ufffdz\ufffdz\ufffd\ufffd\u0012\ufffdD\u001b\ufffdlj罦\ufffd\ufffd\u0003\ufffd'\ufffd}"} 2025-11-10T03:07:31.562Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\ufffd1f\u000b\ufffd\ufffdq[\ufffd\ufffd\ufffd`)x\ufffd\ufffdw\ufffdj:\ufffdH\u0001\ufffd⩲\ufffd\ufffd\ufffd\ufffd\ufffd"} 2025-11-10T03:07:31.562Z DEBUG transaction/worker.go:253 [mvc] see no old txns {"clientID": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "nonce": 112404} 2025-11-10T03:07:31.562Z INFO memorystore/collection.go:65 Redis returned 0 rows after seclect 2025-11-10T03:07:31.562Z DEBUG chain/lfb_round_node.go:33 [mvc] store lfb {"round": 220365, "block": "d1908c8dca3d93b96877cd4a747d69891898951bc599b2a584e58c5907e29b69", "mb number": 1} 2025-11-10T03:07:31.562Z DEBUG transaction/worker.go:221 [mvc] remove old nonce txns {"clientID": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "nonce": 112404} 2025-11-10T03:07:31.562Z DEBUG chain/worker.go:443 BC is moving {"current_lfb_round": 220365, "last_round": 220364} 2025-11-10T03:07:31.562Z DEBUG chain/entity.go:2269 set lfb {"round": 220365, "block": "d1908c8dca3d93b96877cd4a747d69891898951bc599b2a584e58c5907e29b69", "state_computed": true} 2025-11-10T03:07:31.562Z DEBUG chain/state.go:128 finalize round - rebased current state db {"round": 220365, "block": "d1908c8dca3d93b96877cd4a747d69891898951bc599b2a584e58c5907e29b69", "state hash": "16e321ae08596f08b94ea91000f378f273f3086a925e62deb79f98699363f309"} 2025-11-10T03:07:31.562Z DEBUG util/mpt_nodedb.go:556 LevelNodeDB rebase db 2025-11-10T03:07:31.562Z INFO transaction/worker.go:164 cleaning transactions {"collection": "collection.txn:0afc093ffb509f059c55478bc1a60351cef7b4e9c008a53a6cc8241ca8617dfe", "missing_count": 1, "txns": ["ae7fde9171dbbe658e1426372ebca975364490bdbe57286812ab2c5ec9139c16"], "past txns": []} 2025-11-10T03:07:31.562Z INFO memorystore/collection.go:65 Redis returned 0 rows after seclect 2025-11-10T03:07:31.561Z DEBUG chain/protocol_block.go:424 finalize block - record dead nodes {"round": 220365, "block": "d1908c8dca3d93b96877cd4a747d69891898951bc599b2a584e58c5907e29b69", "num dead nodes": 9} 2025-11-10T03:07:31.561Z DEBUG transaction/worker.go:124 cleaning past transactions 2025-11-10T03:07:31.561Z DEBUG miner/round.go:238 Round clear - cancel verification 2025-11-10T03:07:31.561Z DEBUG miner/chain.go:313 delete txns {"txns": ["ae7fde9171dbbe658e1426372ebca975364490bdbe57286812ab2c5ec9139c16"]} 2025-11-10T03:07:31.561Z INFO miner/protocol_block.go:619 update finalized block (debug transaction) {"txn": "ae7fde9171dbbe658e1426372ebca975364490bdbe57286812ab2c5ec9139c16", "block": "d1908c8dca3d93b96877cd4a747d69891898951bc599b2a584e58c5907e29b69"} 2025-11-10T03:07:31.561Z INFO miner/protocol_block.go:613 update finalized block {"round": 220365, "block": "d1908c8dca3d93b96877cd4a747d69891898951bc599b2a584e58c5907e29b69", "lf_round": 220364, "current_round": 220369, "weight": 1} 2025-11-10T03:07:31.561Z DEBUG chain/protocol_block.go:409 MPT state node stat - inc {"node num": -421021, "change num": 9, "delete num": 9} 2025-11-10T03:07:31.561Z INFO miner/protocol_bls.go:489 Not yet reached threshold {"vrfShares_num": 1, "threshold": 2, "round": 220369} 2025-11-10T03:07:31.561Z DEBUG round/entity.go:684 add_vrf_share {"round": 220369, "round_vrf_num": 1, "threshold": 2} 2025-11-10T03:07:31.561Z INFO block/entity.go:1195 save state {"round": 220365, "block": "d1908c8dca3d93b96877cd4a747d69891898951bc599b2a584e58c5907e29b69", "block_size": 1, "changes": 9, "client_state": "16e321ae08596f08b94ea91000f378f273f3086a925e62deb79f98699363f309", "duration": "1.094029ms"} 2025-11-10T03:07:31.561Z INFO miner/protocol_bls.go:430 verified vrf {"round": 220369, "node_id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "share": "1 23c3e07d00fed45a9c93b30b2134ec1b9a45624ffbcb3c589dd1fb1f2068ab0a 1796f4d3f23f5eed4d19ba5122fda98eb3f65936fe08bfad5924e2cdb3c30f25", "from": "196b96df7631e00d339f9a25131927c4", "message": "2203690a3ee2bd0a6a5df3"} 2025-11-10T03:07:31.560Z DEBUG util/merkle_patricia_trie.go:272 MPT save changes success {"duration": "738.626µs"} 2025-11-10T03:07:31.560Z DEBUG util/mpt_node_change.go:156 MPT - update changes done {"changes": 9} 2025-11-10T03:07:31.560Z DEBUG bls/dkg.go:396 dkg verify {"id": "196b96df7631e00d339f9a25131927c4", "key": "1 1f8c72cc3a6b74f6ad7528172b64afe3dc42ee1987495659fe2cf34e749caa7c 20957b4d25e7b5fb1e32d4e3b93e2b73dad7f118efb6dae28715e4ad627b0fff 14259a6ddf4b44c83c1389bd8ed1fc47c1b099c5986bb33923bbcbb25d30054a 2100bb7434dadde1a5ed8545748d0958955bcd21e06cf170f78dbda35a9e04b7", "msg": "2203690a3ee2bd0a6a5df3", "sig": "1 23c3e07d00fed45a9c93b30b2134ec1b9a45624ffbcb3c589dd1fb1f2068ab0a 1796f4d3f23f5eed4d19ba5122fda98eb3f65936fe08bfad5924e2cdb3c30f25"} 2025-11-10T03:07:31.560Z DEBUG util/mpt_node_change.go:150 MPT - update changes {"changes": 9} 2025-11-10T03:07:31.560Z INFO miner/protocol_bls.go:265 BLS sign VRF share calculated for {"round": 220369, "round_timeout": 0, "prev_rseed": 738276690486779379, "prev round vrf random seed": "a3ee2bd0a6a5df3", "bls_msg": "2203690a3ee2bd0a6a5df3"} 2025-11-10T03:07:31.560Z INFO miner/protocol_bls.go:364 DKG AddVRFShare {"round": 220369, "round_vrf_num": 0, "threshold": 2, "sender": 1, "round_timeout_count": 0, "vrf_timeout_count": 0, "vrf_share": "1 23c3e07d00fed45a9c93b30b2134ec1b9a45624ffbcb3c589dd1fb1f2068ab0a 1796f4d3f23f5eed4d19ba5122fda98eb3f65936fe08bfad5924e2cdb3c30f25"} 2025-11-10T03:07:31.560Z INFO miner/protocol_round.go:78 add_my_vrf_share {"round": 220369, "round_timeout": 0, "dkg_starting_round": 0, "dkg_mb_number": 1, "pr_seed": 738276690486779379, "pr_vrf_seed": "a3ee2bd0a6a5df3", "share": "1 23c3e07d00fed45a9c93b30b2134ec1b9a45624ffbcb3c589dd1fb1f2068ab0a 1796f4d3f23f5eed4d19ba5122fda98eb3f65936fe08bfad5924e2cdb3c30f25"} 2025-11-10T03:07:31.560Z DEBUG miner/protocol_bls.go:305 get_bls_share {"round": 220369, "rtc": 0, "dkg_pi": "1 1f8c72cc3a6b74f6ad7528172b64afe3dc42ee1987495659fe2cf34e749caa7c 20957b4d25e7b5fb1e32d4e3b93e2b73dad7f118efb6dae28715e4ad627b0fff 14259a6ddf4b44c83c1389bd8ed1fc47c1b099c5986bb33923bbcbb25d30054a 2100bb7434dadde1a5ed8545748d0958955bcd21e06cf170f78dbda35a9e04b7", "dkg_sr": 0, "mb_sr": 0, "share": "1 23c3e07d00fed45a9c93b30b2134ec1b9a45624ffbcb3c589dd1fb1f2068ab0a 1796f4d3f23f5eed4d19ba5122fda98eb3f65936fe08bfad5924e2cdb3c30f25"} 2025-11-10T03:07:31.560Z INFO round/entity.go:618 get miners by rank {"num_miners": 3, "round": 220365, "r.minerPerm": [2, 0, 1]} 2025-11-10T03:07:31.560Z INFO chain/protocol_block.go:363 finalize block -- round {"round": {"number":220365,"round_random_seed":3826170133534493050,"block_hash":"d1908c8dca3d93b96877cd4a747d69891898951bc599b2a584e58c5907e29b69","vrf_output":"35194976eb88497a1812957c63629606d0012a4cf8021d2c73ec9c128facf565"}, "block": "d1908c8dca3d93b96877cd4a747d69891898951bc599b2a584e58c5907e29b69"} 2025-11-10T03:07:31.560Z INFO chain/protocol_block.go:328 finalize block {"round": 220365, "current_round": 220369, "lf_round": 220364, "hash": "d1908c8dca3d93b96877cd4a747d69891898951bc599b2a584e58c5907e29b69", "round_rank": 0, "state": 7} 2025-11-10T03:07:31.560Z DEBUG chain/worker.go:262 start to finalize block {"round": 220365, "block": "d1908c8dca3d93b96877cd4a747d69891898951bc599b2a584e58c5907e29b69", "prev block": "6478433e36a3efc82976064b680d884a60f9221f46a91b3fe082ee21ab9a266f"} 2025-11-10T03:07:31.559Z INFO chain/protocol_round.go:359 finalize round {"round": 220365, "lfb round": 220367, "block": "d1908c8dca3d93b96877cd4a747d69891898951bc599b2a584e58c5907e29b69"} 2025-11-10T03:07:31.559Z INFO chain/protocol_round.go:326 finalize round - latest finalized round {"round": 220368, "lfb round": 220367, "lfb block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e"} 2025-11-10T03:07:31.559Z INFO chain/protocol_round.go:199 finalize round {"round": 220368, "plfb_round": 220364, "num_round_notarized": 1, "num_chain_notarized": 3} 2025-11-10T03:07:31.559Z DEBUG bls/dkg.go:356 dkg sign {"key": "1ef4cd5ccbeb2dfce1247caae9b2222f43537288563d8624eeb7f5102005c109", "pi": "1 1f8c72cc3a6b74f6ad7528172b64afe3dc42ee1987495659fe2cf34e749caa7c 20957b4d25e7b5fb1e32d4e3b93e2b73dad7f118efb6dae28715e4ad627b0fff 14259a6ddf4b44c83c1389bd8ed1fc47c1b099c5986bb33923bbcbb25d30054a 2100bb7434dadde1a5ed8545748d0958955bcd21e06cf170f78dbda35a9e04b7"} 2025-11-10T03:07:31.559Z DEBUG chain/protocol_round.go:160 finalize round {"round": 220368, "lf_round": 220364} 2025-11-10T03:07:31.559Z DEBUG miner/protocol_bls.go:293 Sign msg with dkg {"msg": "2203690a3ee2bd0a6a5df3", "round": 220369, "dkg starting round": 0} 2025-11-10T03:07:31.559Z INFO miner/protocol_bls.go:265 BLS sign VRF share calculated for {"round": 220369, "round_timeout": 0, "prev_rseed": 738276690486779379, "prev round vrf random seed": "a3ee2bd0a6a5df3", "bls_msg": "2203690a3ee2bd0a6a5df3"} 2025-11-10T03:07:31.559Z INFO miner/protocol_bls.go:283 DKG getBlsShare {"Round Number": 220369} 2025-11-10T03:07:31.559Z INFO miner/protocol_round.go:244 StartNextRound - add VRF {"round": 220369} 2025-11-10T03:07:31.559Z INFO miner/round.go:40 Try to cancel block generation that have not been started yet {"round": 220368} 2025-11-10T03:07:31.559Z DEBUG miner/protocol_round.go:210 finalizedRound - cancel round verification {"round": 220368} 2025-11-10T03:07:31.559Z INFO chain/entity.go:2016 Moving to the next round {"next_round": 220369} 2025-11-10T03:07:31.559Z DEBUG miner/protocol_round.go:154 [wait not ahead] [2] not ahead, can move on {"round": 220368, "lfb tk round": 220364} 2025-11-10T03:07:31.559Z DEBUG miner/protocol_round.go:123 [wait not ahead] 2025-11-10T03:07:31.559Z DEBUG miner/protocol_round.go:991 verification_complete {"top_verified_rank": 0} 2025-11-10T03:07:31.559Z INFO miner/protocol_round.go:986 verification_complete {"round": 220368, "verified_blocks": 0} 2025-11-10T03:07:31.559Z DEBUG miner/protocol_round.go:943 verifyAndSend - finished successfully {"round": 220368, "block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9"} 2025-11-10T03:07:31.559Z INFO miner/round.go:40 Try to cancel block generation that have not been started yet {"round": 220368} 2025-11-10T03:07:31.559Z INFO miner/round.go:230 Cancelling verification {"round": 220368} 2025-11-10T03:07:31.559Z INFO miner/protocol_receive.go:456 process notarization - start next round {"new round": 220369} 2025-11-10T03:07:31.559Z DEBUG miner/protocol_round.go:1149 check block notarization - block notarized {"round": 220368, "block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9"} 2025-11-10T03:07:31.559Z DEBUG round/entity.go:344 reached notarization {"round": 220368} 2025-11-10T03:07:31.559Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 220368, "randk": 0, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T03:07:31.559Z INFO chain/entity.go:1571 Adding a notarized block for current round {"Round": 220368} 2025-11-10T03:07:31.559Z INFO chain/protocol_block.go:303 reached notarization - add tickets {"round": 220368, "current_round": 220368, "block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9", "tickets_num": 2} 2025-11-10T03:07:31.559Z INFO miner/protocol_round.go:920 verifyAndSend - sending verification ticket {"round": 220368, "block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9", "block_rank": 0, "RRS": 738276690486779379} 2025-11-10T03:07:31.559Z INFO chain/protocol_block.go:319 reached notarization - merging tickets {"round": 220367, "current_round": 220368, "block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e", "tickets_num": 3} 2025-11-10T03:07:31.559Z DEBUG miner/protocol_round.go:1069 verify round block - finished verification {"block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9"} 2025-11-10T03:07:31.559Z INFO miner/protocol_block.go:376 verify block successful {"round": 220368, "block_size": 2, "time": "13.960415ms", "block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9", "prev_block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e", "state_hash": "5ea97bb785ede9d7c5768c8aae547ddce98afeb752aa443ed99f3916101dd605", "state_status": 4} 2025-11-10T03:07:31.559Z DEBUG miner/protocol_block.go:374 SignBlock finished {"block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9", "spent": "133.731µs"} 2025-11-10T03:07:31.559Z DEBUG miner/protocol_block.go:367 VerifyBlockMagicBlock finished {"block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9", "spent": "420ns"} 2025-11-10T03:07:31.559Z DEBUG miner/protocol_block.go:360 verifySmartContracts finished {"block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9", "spent": "4.46µs"} 2025-11-10T03:07:31.559Z DEBUG miner/protocol_block.go:351 verify block - ComputeState finished {"round": 220368, "block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9", "spent": "8.749133ms"} 2025-11-10T03:07:31.559Z INFO block/entity.go:1034 compute state successful {"round": 220368, "block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9", "block ptr": "0xc016f73680", "block_size": 2, "duration": "8.705942ms", "changes": 11, "begin_client_state": "0bfec0f92e39abafd9673edecc2bce26d769b6e8d1a0aaeeef98490e1d08a094", "computed_state_hash": "5ea97bb785ede9d7c5768c8aae547ddce98afeb752aa443ed99f3916101dd605", "block_state_hash": "5ea97bb785ede9d7c5768c8aae547ddce98afeb752aa443ed99f3916101dd605", "prev_block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e", "prev_block_client_state": "0bfec0f92e39abafd9673edecc2bce26d769b6e8d1a0aaeeef98490e1d08a094"} 2025-11-10T03:07:31.559Z DEBUG statecache/statecache.go:131 statecache - commit {"block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9", "bc_hits": 80, "bc_miss": 0, "sc_hits": 20104535, "sc_miss": 6214, "duration": "231.972µs"} 2025-11-10T03:07:31.558Z DEBUG chain/state.go:961 Updating nonce {"client": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "new_nonce": 113389} 2025-11-10T03:07:31.558Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T03:07:31.558Z INFO chain/state.go:533 SC executed {"client id": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9", "round": 220368, "prev_state_hash": "0bfec0f92e39abafd9673edecc2bce26d769b6e8d1a0aaeeef98490e1d08a094", "txn_hash": "7725506ebb969276623bb2bd17b2fdb7dcf8c2e76ea1f12533a77d56b964f378", "txn_nonce": 113389, "txn_func": "generate_challenge", "txn_status": 1, "txn_exec_time": "214.062µs", "begin client state": "68461a87e0968d86d9af8bc0fc76b4f2f08f2987a1d5c5dbe3c974a4f4f74c50", "current_root": "68461a87e0968d86d9af8bc0fc76b4f2f08f2987a1d5c5dbe3c974a4f4f74c50", "mpt_cache_hit": 10, "mpt_cache_miss": 0, "output": "OpenChallenges generated"} 2025-11-10T03:07:31.558Z INFO storagesc/challenge.go:1191 skipping generate challenge: empty blobber challenge partition 2025-11-10T03:07:31.558Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "eaf4195ad8a6c0bd8f90e9b28f4ba3b4938ddc60155952285997f669446bb502"} 2025-11-10T03:07:31.557Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T03:07:31.557Z DEBUG chain/state.go:961 Updating nonce {"client": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "new_nonce": 113388} 2025-11-10T03:07:31.556Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T03:07:31.556Z INFO chain/state.go:533 SC executed {"client id": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9", "round": 220368, "prev_state_hash": "0bfec0f92e39abafd9673edecc2bce26d769b6e8d1a0aaeeef98490e1d08a094", "txn_hash": "3706b5aece9d73838045a9d1b43de9b6ecf18f4c2bed9c8884ecdf90d6f1310b", "txn_nonce": 113388, "txn_func": "payFees", "txn_status": 1, "txn_exec_time": "5.994889ms", "begin client state": "0bfec0f92e39abafd9673edecc2bce26d769b6e8d1a0aaeeef98490e1d08a094", "current_root": "b0b3da78d5298c7a131d6b54c6bbc7f67ea9a59146c8f0e12fe8411376ca9318", "mpt_cache_hit": 44, "mpt_cache_miss": 0, "output": ""} 2025-11-10T03:07:31.556Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T03:07:31.556Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T03:07:31.555Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T03:07:31.555Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T03:07:31.551Z ERROR minersc/global_node.go:372 failed to get current magic block {"error": "value not present"} 2025-11-10T03:07:31.551Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "6dba10422e368813802877a85039d3985d96760ed844092319743fb3a76712d9d2208fe938b7465b9c5dc571053986cf8dbf3585fb36399f98ea569c42f50b76"} 2025-11-10T03:07:31.551Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "6dba10422e368813802877a85039d3985d96760ed844092319743fb3a76712d9b5e8a1650666fdd3a9de7855b6da63ab629b1701f23738477e2325f7ca2150ac"} 2025-11-10T03:07:31.551Z DEBUG minersc/fees.go:480 pay_fees, got miner id successfully {"miner id": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "round": 220368, "block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9"} 2025-11-10T03:07:31.551Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T03:07:31.550Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T03:07:31.550Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T03:07:31.550Z DEBUG miner/protocol_block.go:339 ValidateBlockCost {"round": 220368, "hash": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9", "calculated cost": 100} 2025-11-10T03:07:31.550Z DEBUG statecache/statecache.go:173 state cache - see gap {"block": "882f02d1a21ff33e5869b48b22636ae9e347097a5f2a60fe17bc24c417618cf2"} 2025-11-10T03:07:31.549Z DEBUG statecache/statecache.go:173 state cache - see gap {"block": "882f02d1a21ff33e5869b48b22636ae9e347097a5f2a60fe17bc24c417618cf2"} 2025-11-10T03:07:31.548Z DEBUG miner/protocol_block.go:305 ValidateTransactions finished {"block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9", "spent": "2.161987ms"} 2025-11-10T03:07:31.547Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"verification_ticket","value":"Verification Ticket"}, "sender_index": 1, "id": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "duration": "1.19256ms"} 2025-11-10T03:07:31.547Z INFO miner/protocol_round.go:1127 checkBlockNotarization -- block is not Notarized. Returning {"round": 220368, "block hash": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9"} 2025-11-10T03:07:31.547Z INFO chain/protocol_block.go:225 not reached notarization {"mb_sr": 0, "active_miners": 3, "threshold": 2, "num_signatures": 1, "current_round": 220368, "round": 220368} 2025-11-10T03:07:31.547Z DEBUG miner/protocol_receive.go:298 handle vt. msg - verify ticket successfully {"round": 220368, "block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9", "verifier": 2} 2025-11-10T03:07:31.546Z DEBUG miner/protocol_block.go:299 GetPreviousBlock finished {"block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9", "spent": "1.1µs"} 2025-11-10T03:07:31.546Z DEBUG miner/protocol_block.go:292 VerifyBlockMagicBlockReference finished {"block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9", "spent": "3.02µs"} 2025-11-10T03:07:31.546Z DEBUG miner/protocol_block.go:286 Validating finished {"block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9", "spent": "975.518µs"} 2025-11-10T03:07:31.546Z DEBUG miner/worker.go:53 message {"msg": {"code":"verification_ticket","value":"Verification Ticket"}, "sender_index": 1, "id": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea"} 2025-11-10T03:07:31.545Z DEBUG miner/m_handler.go:365 handle vt. msg - verification ticket {"round": 220368, "block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9"} 2025-11-10T03:07:31.545Z DEBUG miner/protocol_round.go:1067 verify round block - started verification {"block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9"} 2025-11-10T03:07:31.545Z DEBUG miner/protocol_round.go:1040 verify round block {"round": 220368, "block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9"} 2025-11-10T03:07:31.545Z DEBUG miner/protocol_round.go:865 verifyAndSend - started {"block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9"} 2025-11-10T03:07:31.545Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 220368, "randk": 1, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T03:07:31.545Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 220368, "randk": 0, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T03:07:31.545Z INFO miner/protocol_round.go:951 Started main verification loop {"round": 220368} 2025-11-10T03:07:31.512Z DEBUG chain/protocol_lfb_ticket.go:386 update lfb ticket - ticket.Round <= latest.Round {"ticket.Round": 220364, "latest.Round": 220364} 2025-11-10T03:07:31.512Z DEBUG chain/protocol_lfb_ticket.go:386 update lfb ticket - ticket.Round <= latest.Round {"ticket.Round": 220364, "latest.Round": 220364} 2025-11-10T03:07:31.502Z DEBUG chain/entity.go:440 process block, no block in buffer {"current round": 220368} 2025-11-10T03:07:31.401Z DEBUG chain/entity.go:440 process block, no block in buffer {"current round": 220368} 2025-11-10T03:07:31.385Z DEBUG miner/protocol_round.go:1028 verify block - pending {"round": 220368, "block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9"} 2025-11-10T03:07:31.385Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 220368, "randk": 0, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T03:07:31.385Z DEBUG miner/protocol_receive.go:130 verify block processed {"round": 220368, "block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9"} 2025-11-10T03:07:31.385Z DEBUG miner/protocol_round.go:759 update prev block notarization, already notarized {"round": 220367, "block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e"} 2025-11-10T03:07:31.385Z DEBUG miner/round.go:143 Adding block to verifyChannel {"round": 220368, "block hash": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9", "magic block": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "magic block round": 0} 2025-11-10T03:07:31.385Z INFO miner/protocol_round.go:803 adding block to verify {"round": 220368, "block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9", "prev_block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e", "state_hash": "5ea97bb785ede9d7c5768c8aae547ddce98afeb752aa443ed99f3916101dd605", "weight": 1} 2025-11-10T03:07:31.385Z INFO miner/protocol_round.go:613 handle verify block - added block for ticket verification {"round": 220368, "block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9", "magic block": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "magic block round": 0} 2025-11-10T03:07:31.385Z INFO chain/protocol_block.go:225 not reached notarization {"mb_sr": 0, "active_miners": 3, "threshold": 2, "num_signatures": 0, "current_round": 220368, "round": 220368} 2025-11-10T03:07:31.384Z DEBUG miner/protocol_receive.go:169 verify block {"round": 220368, "block": "25863b6a16e7dc4482364bc0f4159cfc3dcc8166eed8e63be73583ca3a5231d9"} 2025-11-10T03:07:31.384Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"verify_block","value":"Verify Block"}, "sender_index": 1, "id": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "duration": "44.741µs"} 2025-11-10T03:07:31.384Z DEBUG miner/worker.go:53 message {"msg": {"code":"verify_block","value":"Verify Block"}, "sender_index": 1, "id": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea"} 2025-11-10T03:07:31.383Z DEBUG miner/protocol_round.go:1028 verify block - pending {"round": 220368, "block": "18e6397e3905e696c9f6b87d79102d02775c46db8f7e7b46d06583201b2f0c85"} 2025-11-10T03:07:31.383Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 220368, "randk": 1, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T03:07:31.383Z DEBUG miner/protocol_receive.go:130 verify block processed {"round": 220368, "block": "18e6397e3905e696c9f6b87d79102d02775c46db8f7e7b46d06583201b2f0c85"} 2025-11-10T03:07:31.383Z DEBUG miner/protocol_round.go:759 update prev block notarization, already notarized {"round": 220367, "block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e"} 2025-11-10T03:07:31.383Z DEBUG miner/round.go:143 Adding block to verifyChannel {"round": 220368, "block hash": "18e6397e3905e696c9f6b87d79102d02775c46db8f7e7b46d06583201b2f0c85", "magic block": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "magic block round": 0} 2025-11-10T03:07:31.383Z INFO miner/protocol_round.go:803 adding block to verify {"round": 220368, "block": "18e6397e3905e696c9f6b87d79102d02775c46db8f7e7b46d06583201b2f0c85", "prev_block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e", "state_hash": "6ade038c7a58cb945c5dab551943d8ea6e3df4a0bbc2c7f3024b8ac691177239", "weight": 1} 2025-11-10T03:07:31.383Z INFO miner/protocol_round.go:613 handle verify block - added block for ticket verification {"round": 220368, "block": "18e6397e3905e696c9f6b87d79102d02775c46db8f7e7b46d06583201b2f0c85", "magic block": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "magic block round": 0} 2025-11-10T03:07:31.383Z INFO chain/protocol_block.go:225 not reached notarization {"mb_sr": 0, "active_miners": 3, "threshold": 2, "num_signatures": 0, "current_round": 220368, "round": 220368} 2025-11-10T03:07:31.382Z DEBUG miner/protocol_receive.go:169 verify block {"round": 220368, "block": "18e6397e3905e696c9f6b87d79102d02775c46db8f7e7b46d06583201b2f0c85"} 2025-11-10T03:07:31.382Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"verify_block","value":"Verify Block"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "duration": "65.131µs"} 2025-11-10T03:07:31.382Z DEBUG miner/worker.go:53 message {"msg": {"code":"verify_block","value":"Verify Block"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71"} 2025-11-10T03:07:31.365Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"vrf_share","value":"VRF Share"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "duration": "87.381µs"} 2025-11-10T03:07:31.365Z INFO miner/protocol_bls.go:357 Ignoring VRFShare. Already at threshold {"Round": 220368, "VRF_Shares": 2, "bls_threshold": 2} 2025-11-10T03:07:31.365Z DEBUG miner/protocol_receive.go:26 handle vrf share {"round": 220368, "vrf_timeout_count": 0, "sender_index": 0} 2025-11-10T03:07:31.365Z DEBUG miner/worker.go:53 message {"msg": {"code":"vrf_share","value":"VRF Share"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71"} 2025-11-10T03:07:31.364Z INFO miner/m_handler.go:242 Reject VRFShare: VRF is complete for this round {"vrfs_round_num": 220368, "vrfs_sender_index": 0, "vrfs_round_num": 220368} 2025-11-10T03:07:31.364Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"vrf_share","value":"VRF Share"}, "sender_index": 1, "id": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "duration": "1.404781ms"} 2025-11-10T03:07:31.364Z INFO miner/protocol_round.go:830 Starting round verification {"round": 220368, "delta": "180ms"} 2025-11-10T03:07:31.364Z INFO round/entity.go:618 get miners by rank {"num_miners": 3, "round": 220368, "r.minerPerm": [1, 2, 0]} 2025-11-10T03:07:31.364Z INFO miner/protocol_round.go:322 TOC_FIX Not a generator {"round": 220368, "index": 1, "rank": 2, "timeout_count": 0, "random_seed": 738276690486779379} 2025-11-10T03:07:31.364Z INFO miner/protocol_bls.go:591 Starting round with vrf {"round": 220368, "roundtimeout": 0, "rseed": 738276690486779379, "prev_round": 220367, "Prev_rseed": 0} 2025-11-10T03:07:31.364Z DEBUG miner/protocol_bls.go:542 DKG computeRBO {"round": 220368} 2025-11-10T03:07:31.364Z INFO miner/protocol_bls.go:524 receive bls sign {"round": 220368, "group_signature": "1 d0ed1f93e571024359efafdb3046ce2543b0957b3f2563aab675cba74714eba be4f3edcf9925f2d008498321635f49bf1953dcdc18444be39d3b2962bb0b01", "rboOutput": "0a3ee2bd0a6a5df3ca1998846f6c4b2aa4cde575200aba92d259f93c2bd5aad6", "dkg_starting_round": 0, "dkg_mb_number": 1} 2025-11-10T03:07:31.363Z DEBUG miner/protocol_bls.go:496 VRF Hurray we've threshold BLS shares {"round": 220368, "round pointer": "0xc00cf4da70"} 2025-11-10T03:07:31.363Z DEBUG round/entity.go:684 add_vrf_share {"round": 220368, "round_vrf_num": 2, "threshold": 2} 2025-11-10T03:07:31.363Z INFO miner/protocol_bls.go:430 verified vrf {"round": 220368, "node_id": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "share": "1 18be6e6535dbe26feb85a580cee855debafa69683ec1aa25dfb6e6757b4c8d09 61a41ba0902c50d6a5871bf0c469106483faef7f7f6aefbfd4a93c09262030f", "from": "1c3227e496fdf3c9aa604f3470a2bbd1", "message": "2203680-57df45ef400a6357"} 2025-11-10T03:07:31.363Z DEBUG bls/dkg.go:396 dkg verify {"id": "1c3227e496fdf3c9aa604f3470a2bbd1", "key": "1 6603e20478fac2c72a61b85056977b92696b8fffd408d8acac0e1f47aed3f96 1501242ed9000d9c6a02764160261164a52360a692c34ed452ff097bc90ee9b3 7f8aaa178d31fa4cbd0c1974768dfa4921e29405754ebf8d2c163a774b741a2 24515e04bd685a5559260f5d1868e5ea11abaf21f55a56aee52c15d9f3c2b053", "msg": "2203680-57df45ef400a6357", "sig": "1 18be6e6535dbe26feb85a580cee855debafa69683ec1aa25dfb6e6757b4c8d09 61a41ba0902c50d6a5871bf0c469106483faef7f7f6aefbfd4a93c09262030f"} 2025-11-10T03:07:31.363Z INFO miner/protocol_bls.go:265 BLS sign VRF share calculated for {"round": 220368, "round_timeout": 0, "prev_rseed": -6331856494980129623, "prev round vrf random seed": "-57df45ef400a6357", "bls_msg": "2203680-57df45ef400a6357"} 2025-11-10T03:07:31.363Z INFO miner/protocol_bls.go:364 DKG AddVRFShare {"round": 220368, "round_vrf_num": 1, "threshold": 2, "sender": 1, "round_timeout_count": 0, "vrf_timeout_count": 0, "vrf_share": "1 18be6e6535dbe26feb85a580cee855debafa69683ec1aa25dfb6e6757b4c8d09 61a41ba0902c50d6a5871bf0c469106483faef7f7f6aefbfd4a93c09262030f"} 2025-11-10T03:07:31.363Z DEBUG miner/protocol_receive.go:26 handle vrf share {"round": 220368, "vrf_timeout_count": 0, "sender_index": 1} 2025-11-10T03:07:31.363Z DEBUG miner/worker.go:53 message {"msg": {"code":"vrf_share","value":"VRF Share"}, "sender_index": 1, "id": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea"} 2025-11-10T03:07:31.359Z INFO chain/entity.go:1721 delete blocks below round {"round": 220368, "below_round": 220314, "before": 1762743991, "total": 309, "count": 0} 2025-11-10T03:07:31.359Z DEBUG chain/protocol_round.go:334 finalize round - block has less than 3 confirmation 2025-11-10T03:07:31.359Z DEBUG chain/protocol_round.go:334 finalize round - block has less than 3 confirmation 2025-11-10T03:07:31.359Z INFO chain/protocol_round.go:402 finalize round - finalize block success {"round": 220364, "block": "6478433e36a3efc82976064b680d884a60f9221f46a91b3fe082ee21ab9a266f", "duration": "3.874071ms"} 2025-11-10T03:07:31.359Z DEBUG chain/worker.go:230 finalize block processed {"round": 220364, "duration": "3.833031ms"} 2025-11-10T03:07:31.359Z DEBUG chain/protocol_block.go:612 finalized block - done {"round": 220364, "block": "6478433e36a3efc82976064b680d884a60f9221f46a91b3fe082ee21ab9a266f", "duration": "3.719731ms"} 2025-11-10T03:07:31.359Z INFO chain/entity.go:2366 config has been updated successfully {"start of round": 220364} 2025-11-10T03:07:31.359Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\ufffd\u001e\ufffd-7cq\u000e\ufffd\ufffdz\ufffdz\ufffd\ufffd\u0012\ufffdD\u001b\ufffdlj罦\ufffd\ufffd\u0003\ufffd'\ufffd}"} 2025-11-10T03:07:31.359Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\ufffd1f\u000b\ufffd\ufffdq[\ufffd\ufffd\ufffd`)x\ufffd\ufffdw\ufffdj:\ufffdH\u0001\ufffd⩲\ufffd\ufffd\ufffd\ufffd\ufffd"} 2025-11-10T03:07:31.359Z DEBUG transaction/worker.go:253 [mvc] see no old txns {"clientID": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "nonce": 112403} 2025-11-10T03:07:31.359Z INFO memorystore/collection.go:65 Redis returned 0 rows after seclect 2025-11-10T03:07:31.358Z DEBUG chain/lfb_round_node.go:33 [mvc] store lfb {"round": 220364, "block": "6478433e36a3efc82976064b680d884a60f9221f46a91b3fe082ee21ab9a266f", "mb number": 1} 2025-11-10T03:07:31.358Z DEBUG chain/worker.go:443 BC is moving {"current_lfb_round": 220364, "last_round": 220363} 2025-11-10T03:07:31.358Z DEBUG transaction/worker.go:221 [mvc] remove old nonce txns {"clientID": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "nonce": 112403} 2025-11-10T03:07:31.358Z DEBUG chain/entity.go:2269 set lfb {"round": 220364, "block": "6478433e36a3efc82976064b680d884a60f9221f46a91b3fe082ee21ab9a266f", "state_computed": true} 2025-11-10T03:07:31.358Z DEBUG chain/state.go:128 finalize round - rebased current state db {"round": 220364, "block": "6478433e36a3efc82976064b680d884a60f9221f46a91b3fe082ee21ab9a266f", "state hash": "3ef4ba41f553989c80057eaef74e4edbb59a3af6bad3982fe7e40eeb264df1ec"} 2025-11-10T03:07:31.358Z DEBUG util/mpt_nodedb.go:556 LevelNodeDB rebase db 2025-11-10T03:07:31.358Z INFO transaction/worker.go:164 cleaning transactions {"collection": "collection.txn:0afc093ffb509f059c55478bc1a60351cef7b4e9c008a53a6cc8241ca8617dfe", "missing_count": 2, "txns": ["102264185d1e532c09c920d3360c9f0956d921f7292981bdb99afdecfab0f30a", "f214eb6912837ee0516ed241d96c44d96d8003dd84b10bc3e1b5c8dc6ca456b5"], "past txns": []} 2025-11-10T03:07:31.358Z DEBUG chain/protocol_block.go:424 finalize block - record dead nodes {"round": 220364, "block": "6478433e36a3efc82976064b680d884a60f9221f46a91b3fe082ee21ab9a266f", "num dead nodes": 12} 2025-11-10T03:07:31.358Z INFO memorystore/collection.go:65 Redis returned 0 rows after seclect 2025-11-10T03:07:31.358Z DEBUG transaction/worker.go:124 cleaning past transactions 2025-11-10T03:07:31.358Z DEBUG miner/round.go:238 Round clear - cancel verification 2025-11-10T03:07:31.358Z DEBUG miner/chain.go:313 delete txns {"txns": ["102264185d1e532c09c920d3360c9f0956d921f7292981bdb99afdecfab0f30a", "f214eb6912837ee0516ed241d96c44d96d8003dd84b10bc3e1b5c8dc6ca456b5"]} 2025-11-10T03:07:31.358Z INFO miner/protocol_block.go:619 update finalized block (debug transaction) {"txn": "f214eb6912837ee0516ed241d96c44d96d8003dd84b10bc3e1b5c8dc6ca456b5", "block": "6478433e36a3efc82976064b680d884a60f9221f46a91b3fe082ee21ab9a266f"} 2025-11-10T03:07:31.358Z INFO miner/protocol_block.go:619 update finalized block (debug transaction) {"txn": "102264185d1e532c09c920d3360c9f0956d921f7292981bdb99afdecfab0f30a", "block": "6478433e36a3efc82976064b680d884a60f9221f46a91b3fe082ee21ab9a266f"} 2025-11-10T03:07:31.358Z INFO miner/protocol_block.go:613 update finalized block {"round": 220364, "block": "6478433e36a3efc82976064b680d884a60f9221f46a91b3fe082ee21ab9a266f", "lf_round": 220363, "current_round": 220368, "weight": 1} 2025-11-10T03:07:31.358Z DEBUG chain/protocol_block.go:409 MPT state node stat - inc {"node num": -421030, "change num": 9, "delete num": 12} 2025-11-10T03:07:31.357Z INFO block/entity.go:1195 save state {"round": 220364, "block": "6478433e36a3efc82976064b680d884a60f9221f46a91b3fe082ee21ab9a266f", "block_size": 2, "changes": 9, "client_state": "3ef4ba41f553989c80057eaef74e4edbb59a3af6bad3982fe7e40eeb264df1ec", "duration": "1.595883ms"} 2025-11-10T03:07:31.357Z INFO miner/protocol_bls.go:489 Not yet reached threshold {"vrfShares_num": 1, "threshold": 2, "round": 220368} 2025-11-10T03:07:31.357Z DEBUG round/entity.go:684 add_vrf_share {"round": 220368, "round_vrf_num": 1, "threshold": 2} 2025-11-10T03:07:31.357Z INFO miner/protocol_bls.go:430 verified vrf {"round": 220368, "node_id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "share": "1 13fa341f27d18035cacc25ddb973f24502f58ac33a40c576d34caa148bda0461 16c7cf06da76228e0f35fe3714f0c5c72d8a433f21f5555991ffa1f1e4fad2fe", "from": "196b96df7631e00d339f9a25131927c4", "message": "2203680-57df45ef400a6357"} 2025-11-10T03:07:31.357Z DEBUG util/merkle_patricia_trie.go:272 MPT save changes success {"duration": "1.102999ms"} 2025-11-10T03:07:31.357Z DEBUG util/mpt_node_change.go:156 MPT - update changes done {"changes": 9} 2025-11-10T03:07:31.356Z DEBUG util/mpt_node_change.go:150 MPT - update changes {"changes": 9} 2025-11-10T03:07:31.356Z DEBUG bls/dkg.go:396 dkg verify {"id": "196b96df7631e00d339f9a25131927c4", "key": "1 1f8c72cc3a6b74f6ad7528172b64afe3dc42ee1987495659fe2cf34e749caa7c 20957b4d25e7b5fb1e32d4e3b93e2b73dad7f118efb6dae28715e4ad627b0fff 14259a6ddf4b44c83c1389bd8ed1fc47c1b099c5986bb33923bbcbb25d30054a 2100bb7434dadde1a5ed8545748d0958955bcd21e06cf170f78dbda35a9e04b7", "msg": "2203680-57df45ef400a6357", "sig": "1 13fa341f27d18035cacc25ddb973f24502f58ac33a40c576d34caa148bda0461 16c7cf06da76228e0f35fe3714f0c5c72d8a433f21f5555991ffa1f1e4fad2fe"} 2025-11-10T03:07:31.356Z INFO miner/protocol_bls.go:265 BLS sign VRF share calculated for {"round": 220368, "round_timeout": 0, "prev_rseed": -6331856494980129623, "prev round vrf random seed": "-57df45ef400a6357", "bls_msg": "2203680-57df45ef400a6357"} 2025-11-10T03:07:31.356Z INFO miner/protocol_bls.go:364 DKG AddVRFShare {"round": 220368, "round_vrf_num": 0, "threshold": 2, "sender": 1, "round_timeout_count": 0, "vrf_timeout_count": 0, "vrf_share": "1 13fa341f27d18035cacc25ddb973f24502f58ac33a40c576d34caa148bda0461 16c7cf06da76228e0f35fe3714f0c5c72d8a433f21f5555991ffa1f1e4fad2fe"} 2025-11-10T03:07:31.356Z INFO miner/protocol_round.go:78 add_my_vrf_share {"round": 220368, "round_timeout": 0, "dkg_starting_round": 0, "dkg_mb_number": 1, "pr_seed": -6331856494980129623, "pr_vrf_seed": "-57df45ef400a6357", "share": "1 13fa341f27d18035cacc25ddb973f24502f58ac33a40c576d34caa148bda0461 16c7cf06da76228e0f35fe3714f0c5c72d8a433f21f5555991ffa1f1e4fad2fe"} 2025-11-10T03:07:31.356Z DEBUG miner/protocol_bls.go:305 get_bls_share {"round": 220368, "rtc": 0, "dkg_pi": "1 1f8c72cc3a6b74f6ad7528172b64afe3dc42ee1987495659fe2cf34e749caa7c 20957b4d25e7b5fb1e32d4e3b93e2b73dad7f118efb6dae28715e4ad627b0fff 14259a6ddf4b44c83c1389bd8ed1fc47c1b099c5986bb33923bbcbb25d30054a 2100bb7434dadde1a5ed8545748d0958955bcd21e06cf170f78dbda35a9e04b7", "dkg_sr": 0, "mb_sr": 0, "share": "1 13fa341f27d18035cacc25ddb973f24502f58ac33a40c576d34caa148bda0461 16c7cf06da76228e0f35fe3714f0c5c72d8a433f21f5555991ffa1f1e4fad2fe"} 2025-11-10T03:07:31.356Z INFO round/entity.go:618 get miners by rank {"num_miners": 3, "round": 220364, "r.minerPerm": [1, 0, 2]} 2025-11-10T03:07:31.356Z INFO chain/protocol_block.go:363 finalize block -- round {"round": {"number":220364,"round_random_seed":3132168231452076180,"block_hash":"6478433e36a3efc82976064b680d884a60f9221f46a91b3fe082ee21ab9a266f","vrf_output":"2b77b2695c76e8949682d56dd661ba85eeea2c7a6f63b59093fb2ca1152c4194"}, "block": "6478433e36a3efc82976064b680d884a60f9221f46a91b3fe082ee21ab9a266f"} 2025-11-10T03:07:31.356Z INFO chain/protocol_block.go:328 finalize block {"round": 220364, "current_round": 220368, "lf_round": 220363, "hash": "6478433e36a3efc82976064b680d884a60f9221f46a91b3fe082ee21ab9a266f", "round_rank": 0, "state": 7} 2025-11-10T03:07:31.355Z DEBUG chain/worker.go:262 start to finalize block {"round": 220364, "block": "6478433e36a3efc82976064b680d884a60f9221f46a91b3fe082ee21ab9a266f", "prev block": "57254eec2972209c1019d35dc0db7d5f45bad3f67ed674427b3a52e45081f03a"} 2025-11-10T03:07:31.355Z INFO chain/protocol_round.go:359 finalize round {"round": 220364, "lfb round": 220366, "block": "6478433e36a3efc82976064b680d884a60f9221f46a91b3fe082ee21ab9a266f"} 2025-11-10T03:07:31.355Z INFO chain/protocol_round.go:326 finalize round - latest finalized round {"round": 220367, "lfb round": 220366, "lfb block": "590839da3aaffc06479d7d48fc9e523f958edee0826341a3e3e0f59b2532b1d2"} 2025-11-10T03:07:31.355Z INFO chain/protocol_round.go:199 finalize round {"round": 220367, "plfb_round": 220363, "num_round_notarized": 1, "num_chain_notarized": 3} 2025-11-10T03:07:31.355Z DEBUG chain/protocol_round.go:160 finalize round {"round": 220367, "lf_round": 220363} 2025-11-10T03:07:31.355Z DEBUG bls/dkg.go:356 dkg sign {"key": "1ef4cd5ccbeb2dfce1247caae9b2222f43537288563d8624eeb7f5102005c109", "pi": "1 1f8c72cc3a6b74f6ad7528172b64afe3dc42ee1987495659fe2cf34e749caa7c 20957b4d25e7b5fb1e32d4e3b93e2b73dad7f118efb6dae28715e4ad627b0fff 14259a6ddf4b44c83c1389bd8ed1fc47c1b099c5986bb33923bbcbb25d30054a 2100bb7434dadde1a5ed8545748d0958955bcd21e06cf170f78dbda35a9e04b7"} 2025-11-10T03:07:31.355Z DEBUG miner/protocol_bls.go:293 Sign msg with dkg {"msg": "2203680-57df45ef400a6357", "round": 220368, "dkg starting round": 0} 2025-11-10T03:07:31.355Z INFO miner/protocol_bls.go:265 BLS sign VRF share calculated for {"round": 220368, "round_timeout": 0, "prev_rseed": -6331856494980129623, "prev round vrf random seed": "-57df45ef400a6357", "bls_msg": "2203680-57df45ef400a6357"} 2025-11-10T03:07:31.355Z INFO miner/protocol_bls.go:283 DKG getBlsShare {"Round Number": 220368} 2025-11-10T03:07:31.355Z INFO miner/protocol_round.go:244 StartNextRound - add VRF {"round": 220368} 2025-11-10T03:07:31.355Z INFO miner/round.go:40 Try to cancel block generation that have not been started yet {"round": 220367} 2025-11-10T03:07:31.355Z DEBUG miner/protocol_round.go:210 finalizedRound - cancel round verification {"round": 220367} 2025-11-10T03:07:31.355Z INFO chain/entity.go:2016 Moving to the next round {"next_round": 220368} 2025-11-10T03:07:31.355Z DEBUG miner/protocol_round.go:154 [wait not ahead] [2] not ahead, can move on {"round": 220367, "lfb tk round": 220363} 2025-11-10T03:07:31.355Z DEBUG miner/protocol_round.go:123 [wait not ahead] 2025-11-10T03:07:31.355Z DEBUG miner/protocol_round.go:991 verification_complete {"top_verified_rank": 0} 2025-11-10T03:07:31.355Z INFO miner/protocol_round.go:986 verification_complete {"round": 220367, "verified_blocks": 0} 2025-11-10T03:07:31.355Z DEBUG miner/protocol_round.go:943 verifyAndSend - finished successfully {"round": 220367, "block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e"} 2025-11-10T03:07:31.355Z INFO miner/round.go:40 Try to cancel block generation that have not been started yet {"round": 220367} 2025-11-10T03:07:31.355Z INFO miner/round.go:230 Cancelling verification {"round": 220367} 2025-11-10T03:07:31.355Z INFO miner/protocol_receive.go:456 process notarization - start next round {"new round": 220368} 2025-11-10T03:07:31.355Z DEBUG miner/protocol_round.go:1149 check block notarization - block notarized {"round": 220367, "block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e"} 2025-11-10T03:07:31.355Z DEBUG round/entity.go:344 reached notarization {"round": 220367} 2025-11-10T03:07:31.355Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 220367, "randk": 0, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T03:07:31.355Z INFO chain/entity.go:1571 Adding a notarized block for current round {"Round": 220367} 2025-11-10T03:07:31.355Z INFO chain/protocol_block.go:303 reached notarization - add tickets {"round": 220367, "current_round": 220367, "block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e", "tickets_num": 2} 2025-11-10T03:07:31.355Z INFO miner/protocol_round.go:920 verifyAndSend - sending verification ticket {"round": 220367, "block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e", "block_rank": 0, "RRS": -6331856494980129623} 2025-11-10T03:07:31.355Z INFO chain/protocol_block.go:319 reached notarization - merging tickets {"round": 220366, "current_round": 220367, "block": "590839da3aaffc06479d7d48fc9e523f958edee0826341a3e3e0f59b2532b1d2", "tickets_num": 3} 2025-11-10T03:07:31.355Z DEBUG miner/protocol_round.go:1069 verify round block - finished verification {"block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e"} 2025-11-10T03:07:31.355Z INFO miner/protocol_block.go:376 verify block successful {"round": 220367, "block_size": 1, "time": "11.387333ms", "block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e", "prev_block": "590839da3aaffc06479d7d48fc9e523f958edee0826341a3e3e0f59b2532b1d2", "state_hash": "0bfec0f92e39abafd9673edecc2bce26d769b6e8d1a0aaeeef98490e1d08a094", "state_status": 4} 2025-11-10T03:07:31.355Z DEBUG miner/protocol_block.go:374 SignBlock finished {"block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e", "spent": "132.481µs"} 2025-11-10T03:07:31.355Z DEBUG miner/protocol_block.go:367 VerifyBlockMagicBlock finished {"block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e", "spent": "280ns"} 2025-11-10T03:07:31.355Z DEBUG miner/protocol_block.go:360 verifySmartContracts finished {"block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e", "spent": "400ns"} 2025-11-10T03:07:31.355Z DEBUG miner/protocol_block.go:351 verify block - ComputeState finished {"round": 220367, "block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e", "spent": "8.419919ms"} 2025-11-10T03:07:31.354Z INFO block/entity.go:1034 compute state successful {"round": 220367, "block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e", "block ptr": "0xc017fce960", "block_size": 1, "duration": "8.359449ms", "changes": 8, "begin_client_state": "e0ffde27bfe8e4534fa2699958a648688216af4da56f67d45070bedaa036b89b", "computed_state_hash": "0bfec0f92e39abafd9673edecc2bce26d769b6e8d1a0aaeeef98490e1d08a094", "block_state_hash": "0bfec0f92e39abafd9673edecc2bce26d769b6e8d1a0aaeeef98490e1d08a094", "prev_block": "590839da3aaffc06479d7d48fc9e523f958edee0826341a3e3e0f59b2532b1d2", "prev_block_client_state": "e0ffde27bfe8e4534fa2699958a648688216af4da56f67d45070bedaa036b89b"} 2025-11-10T03:07:31.354Z DEBUG statecache/statecache.go:131 statecache - commit {"block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e", "bc_hits": 54, "bc_miss": 0, "sc_hits": 20104455, "sc_miss": 6214, "duration": "194.512µs"} 2025-11-10T03:07:31.354Z DEBUG chain/state.go:961 Updating nonce {"client": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "new_nonce": 113215} 2025-11-10T03:07:31.353Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T03:07:31.353Z INFO chain/state.go:533 SC executed {"client id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e", "round": 220367, "prev_state_hash": "e0ffde27bfe8e4534fa2699958a648688216af4da56f67d45070bedaa036b89b", "txn_hash": "7e0508a76d40253844e7dbd3f696086e8083f59bc2349e6d24b504693a1c05ef", "txn_nonce": 113215, "txn_func": "payFees", "txn_status": 1, "txn_exec_time": "6.899726ms", "begin client state": "e0ffde27bfe8e4534fa2699958a648688216af4da56f67d45070bedaa036b89b", "current_root": "278d171a09812427602311e5fb40dfa7f1d726f0a3432557b09095c67a0da08d", "mpt_cache_hit": 42, "mpt_cache_miss": 0, "output": ""} 2025-11-10T03:07:31.353Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T03:07:31.353Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T03:07:31.352Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T03:07:31.352Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T03:07:31.347Z ERROR minersc/global_node.go:372 failed to get current magic block {"error": "value not present"} 2025-11-10T03:07:31.347Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "6dba10422e368813802877a85039d3985d96760ed844092319743fb3a76712d9d2208fe938b7465b9c5dc571053986cf8dbf3585fb36399f98ea569c42f50b76"} 2025-11-10T03:07:31.347Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "6dba10422e368813802877a85039d3985d96760ed844092319743fb3a76712d9b5e8a1650666fdd3a9de7855b6da63ab629b1701f23738477e2325f7ca2150ac"} 2025-11-10T03:07:31.347Z DEBUG minersc/fees.go:480 pay_fees, got miner id successfully {"miner id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "round": 220367, "block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e"} 2025-11-10T03:07:31.347Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T03:07:31.347Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T03:07:31.346Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T03:07:31.346Z DEBUG miner/protocol_block.go:339 ValidateBlockCost {"round": 220367, "hash": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e", "calculated cost": 0} 2025-11-10T03:07:31.346Z DEBUG miner/protocol_block.go:305 ValidateTransactions finished {"block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e", "spent": "1.482263ms"} 2025-11-10T03:07:31.345Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"verification_ticket","value":"Verification Ticket"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "duration": "1.499893ms"} 2025-11-10T03:07:31.345Z INFO miner/protocol_round.go:1127 checkBlockNotarization -- block is not Notarized. Returning {"round": 220367, "block hash": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e"} 2025-11-10T03:07:31.345Z INFO chain/protocol_block.go:225 not reached notarization {"mb_sr": 0, "active_miners": 3, "threshold": 2, "num_signatures": 1, "current_round": 220367, "round": 220367} 2025-11-10T03:07:31.345Z DEBUG miner/protocol_receive.go:298 handle vt. msg - verify ticket successfully {"round": 220367, "block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e", "verifier": 0} 2025-11-10T03:07:31.344Z DEBUG miner/protocol_block.go:299 GetPreviousBlock finished {"block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e", "spent": "1.15µs"} 2025-11-10T03:07:31.344Z DEBUG miner/protocol_block.go:292 VerifyBlockMagicBlockReference finished {"block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e", "spent": "2.68µs"} 2025-11-10T03:07:31.344Z DEBUG miner/protocol_block.go:286 Validating finished {"block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e", "spent": "935.858µs"} 2025-11-10T03:07:31.343Z DEBUG miner/protocol_round.go:1067 verify round block - started verification {"block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e"} 2025-11-10T03:07:31.343Z DEBUG miner/protocol_round.go:1040 verify round block {"round": 220367, "block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e"} 2025-11-10T03:07:31.343Z DEBUG miner/protocol_round.go:865 verifyAndSend - started {"block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e"} 2025-11-10T03:07:31.343Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 220367, "randk": 1, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T03:07:31.343Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 220367, "randk": 0, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T03:07:31.343Z DEBUG miner/worker.go:53 message {"msg": {"code":"verification_ticket","value":"Verification Ticket"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71"} 2025-11-10T03:07:31.343Z INFO miner/protocol_round.go:951 Started main verification loop {"round": 220367} 2025-11-10T03:07:31.342Z DEBUG miner/m_handler.go:365 handle vt. msg - verification ticket {"round": 220367, "block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e"} 2025-11-10T03:07:31.300Z DEBUG chain/entity.go:440 process block, no block in buffer {"current round": 220367} 2025-11-10T03:07:31.296Z DEBUG chain/protocol_lfb_ticket.go:386 update lfb ticket - ticket.Round <= latest.Round {"ticket.Round": 220363, "latest.Round": 220363} 2025-11-10T03:07:31.293Z DEBUG chain/protocol_lfb_ticket.go:386 update lfb ticket - ticket.Round <= latest.Round {"ticket.Round": 220363, "latest.Round": 220363} 2025-11-10T03:07:31.199Z DEBUG chain/entity.go:440 process block, no block in buffer {"current round": 220367} 2025-11-10T03:07:31.181Z DEBUG miner/protocol_round.go:1028 verify block - pending {"round": 220367, "block": "f1d2cebe915d83bb62193b878f6fa244dca3fcb9f0492c81bd63b5db4dd3174c"} 2025-11-10T03:07:31.181Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 220367, "randk": 1, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T03:07:31.181Z DEBUG miner/protocol_receive.go:130 verify block processed {"round": 220367, "block": "f1d2cebe915d83bb62193b878f6fa244dca3fcb9f0492c81bd63b5db4dd3174c"} 2025-11-10T03:07:31.181Z DEBUG miner/protocol_round.go:759 update prev block notarization, already notarized {"round": 220366, "block": "590839da3aaffc06479d7d48fc9e523f958edee0826341a3e3e0f59b2532b1d2"} 2025-11-10T03:07:31.181Z DEBUG miner/round.go:143 Adding block to verifyChannel {"round": 220367, "block hash": "f1d2cebe915d83bb62193b878f6fa244dca3fcb9f0492c81bd63b5db4dd3174c", "magic block": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "magic block round": 0} 2025-11-10T03:07:31.181Z INFO miner/protocol_round.go:803 adding block to verify {"round": 220367, "block": "f1d2cebe915d83bb62193b878f6fa244dca3fcb9f0492c81bd63b5db4dd3174c", "prev_block": "590839da3aaffc06479d7d48fc9e523f958edee0826341a3e3e0f59b2532b1d2", "state_hash": "b544c5214c938043fa95d87b51b8dc7a7c4662e82965001ca8a8cf32760710ca", "weight": 1} 2025-11-10T03:07:31.181Z INFO miner/protocol_round.go:613 handle verify block - added block for ticket verification {"round": 220367, "block": "f1d2cebe915d83bb62193b878f6fa244dca3fcb9f0492c81bd63b5db4dd3174c", "magic block": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "magic block round": 0} 2025-11-10T03:07:31.181Z INFO chain/protocol_block.go:225 not reached notarization {"mb_sr": 0, "active_miners": 3, "threshold": 2, "num_signatures": 0, "current_round": 220367, "round": 220367} 2025-11-10T03:07:31.180Z DEBUG miner/protocol_receive.go:169 verify block {"round": 220367, "block": "f1d2cebe915d83bb62193b878f6fa244dca3fcb9f0492c81bd63b5db4dd3174c"} 2025-11-10T03:07:31.180Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"verify_block","value":"Verify Block"}, "sender_index": 0, "id": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "duration": "38.75µs"} 2025-11-10T03:07:31.180Z DEBUG miner/worker.go:53 message {"msg": {"code":"verify_block","value":"Verify Block"}, "sender_index": 0, "id": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea"} 2025-11-10T03:07:31.177Z DEBUG miner/protocol_round.go:1028 verify block - pending {"round": 220367, "block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e"} 2025-11-10T03:07:31.177Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 220367, "randk": 0, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T03:07:31.177Z DEBUG miner/protocol_receive.go:130 verify block processed {"round": 220367, "block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e"} 2025-11-10T03:07:31.177Z DEBUG miner/round.go:143 Adding block to verifyChannel {"round": 220367, "block hash": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e", "magic block": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "magic block round": 0} 2025-11-10T03:07:31.177Z INFO miner/protocol_round.go:803 adding block to verify {"round": 220367, "block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e", "prev_block": "590839da3aaffc06479d7d48fc9e523f958edee0826341a3e3e0f59b2532b1d2", "state_hash": "0bfec0f92e39abafd9673edecc2bce26d769b6e8d1a0aaeeef98490e1d08a094", "weight": 1} 2025-11-10T03:07:31.176Z INFO chain/protocol_block.go:319 reached notarization - merging tickets {"round": 220366, "current_round": 220367, "block": "590839da3aaffc06479d7d48fc9e523f958edee0826341a3e3e0f59b2532b1d2", "tickets_num": 3} 2025-11-10T03:07:31.176Z DEBUG miner/protocol_round.go:759 update prev block notarization, already notarized {"round": 220366, "block": "590839da3aaffc06479d7d48fc9e523f958edee0826341a3e3e0f59b2532b1d2"} 2025-11-10T03:07:31.176Z INFO miner/protocol_round.go:613 handle verify block - added block for ticket verification {"round": 220367, "block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e", "magic block": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "magic block round": 0} 2025-11-10T03:07:31.176Z INFO chain/protocol_block.go:225 not reached notarization {"mb_sr": 0, "active_miners": 3, "threshold": 2, "num_signatures": 0, "current_round": 220367, "round": 220367} 2025-11-10T03:07:31.175Z DEBUG miner/protocol_receive.go:169 verify block {"round": 220367, "block": "5fb669ec8777284d5ae0042114869473e338b8f6c867dffa2c3c5c432eb9af0e"} 2025-11-10T03:07:31.175Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"verify_block","value":"Verify Block"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "duration": "44.251µs"} 2025-11-10T03:07:31.175Z DEBUG miner/worker.go:53 message {"msg": {"code":"verify_block","value":"Verify Block"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71"} 2025-11-10T03:07:31.165Z INFO miner/m_handler.go:242 Reject VRFShare: VRF is complete for this round {"vrfs_round_num": 220367, "vrfs_sender_index": 0, "vrfs_round_num": 220367} 2025-11-10T03:07:31.165Z INFO miner/m_handler.go:242 Reject VRFShare: VRF is complete for this round {"vrfs_round_num": 220367, "vrfs_sender_index": 0, "vrfs_round_num": 220367} 2025-11-10T03:07:31.163Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"vrf_share","value":"VRF Share"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "duration": "1.379922ms"} 2025-11-10T03:07:31.163Z INFO miner/protocol_round.go:830 Starting round verification {"round": 220367, "delta": "180ms"} 2025-11-10T03:07:31.163Z INFO round/entity.go:618 get miners by rank {"num_miners": 3, "round": 220367, "r.minerPerm": [0, 2, 1]} 2025-11-10T03:07:31.163Z INFO miner/protocol_round.go:322 TOC_FIX Not a generator {"round": 220367, "index": 1, "rank": 2, "timeout_count": 0, "random_seed": -6331856494980129623} 2025-11-10T03:07:31.163Z INFO miner/protocol_bls.go:591 Starting round with vrf {"round": 220367, "roundtimeout": 0, "rseed": -6331856494980129623, "prev_round": 220366, "Prev_rseed": 0} 2025-11-10T03:07:31.162Z DEBUG miner/protocol_bls.go:542 DKG computeRBO {"round": 220367} 2025-11-10T03:07:31.162Z INFO miner/protocol_bls.go:524 receive bls sign {"round": 220367, "group_signature": "1 144cf0bfd68d5c54852b6a9253136e17ede2753e8fb31541505447f1506302a2 1b153077a3639bb47a7e760f366039b7ca4830f8c7dda63e65b682e4b6aabe22", "rboOutput": "a820ba10bff59ca90cde84d17e5d1459d0701b8a93bf107518a59d22682299d9", "dkg_starting_round": 0, "dkg_mb_number": 1} 2025-11-10T03:07:31.162Z DEBUG miner/protocol_bls.go:496 VRF Hurray we've threshold BLS shares {"round": 220367, "round pointer": "0xc018f8f950"} 2025-11-10T03:07:31.162Z DEBUG round/entity.go:684 add_vrf_share {"round": 220367, "round_vrf_num": 2, "threshold": 2} 2025-11-10T03:07:31.162Z INFO miner/protocol_bls.go:430 verified vrf {"round": 220367, "node_id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "share": "1 15c2bd0967a0b1aecd1dfc265a0d4386395dafaff87a5117054a2e400f910ff9 1a0b5560ac6df2ff16c4ebfcef06dcba72eef9d82c70c79cf6e400a80c53e6aa", "from": "18f9a15b9551f8552a19cf4750ef14bf", "message": "2203670719e4ec8ca26b0df"} 2025-11-10T03:07:31.161Z DEBUG bls/dkg.go:396 dkg verify {"id": "18f9a15b9551f8552a19cf4750ef14bf", "key": "1 15981a99909f8d701bca846be62c295e8958436831d3087ded78a1719a92f9a9 1bc96c0fea12a9ee4451600417977d1e987b252b469ea7c7be9d40e681fceff4 164089f6538d2b42ac3b37af7bc35e2550212af1e8ccedfeec4bde4f472dd384 aa502eaa78fb0cc02bd92538e258b55b1495cdc393205378d4ead83eb106f33", "msg": "2203670719e4ec8ca26b0df", "sig": "1 15c2bd0967a0b1aecd1dfc265a0d4386395dafaff87a5117054a2e400f910ff9 1a0b5560ac6df2ff16c4ebfcef06dcba72eef9d82c70c79cf6e400a80c53e6aa"} 2025-11-10T03:07:31.161Z INFO miner/protocol_bls.go:265 BLS sign VRF share calculated for {"round": 220367, "round_timeout": 0, "prev_rseed": 8187067796898099423, "prev round vrf random seed": "719e4ec8ca26b0df", "bls_msg": "2203670719e4ec8ca26b0df"} 2025-11-10T03:07:31.161Z INFO miner/protocol_bls.go:364 DKG AddVRFShare {"round": 220367, "round_vrf_num": 1, "threshold": 2, "sender": 0, "round_timeout_count": 0, "vrf_timeout_count": 0, "vrf_share": "1 15c2bd0967a0b1aecd1dfc265a0d4386395dafaff87a5117054a2e400f910ff9 1a0b5560ac6df2ff16c4ebfcef06dcba72eef9d82c70c79cf6e400a80c53e6aa"} 2025-11-10T03:07:31.161Z DEBUG miner/protocol_receive.go:26 handle vrf share {"round": 220367, "vrf_timeout_count": 0, "sender_index": 0} 2025-11-10T03:07:31.161Z DEBUG miner/worker.go:53 message {"msg": {"code":"vrf_share","value":"VRF Share"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71"} 2025-11-10T03:07:31.157Z INFO chain/entity.go:1721 delete blocks below round {"round": 220367, "below_round": 220313, "before": 1762743991, "total": 313, "count": 5} 2025-11-10T03:07:31.157Z DEBUG chain/entity.go:1714 found block to delete {"round": 220313, "block_round": 220068, "current_round": 220367, "lf_round": 220363} 2025-11-10T03:07:31.157Z DEBUG chain/entity.go:1714 found block to delete {"round": 220313, "block_round": 220067, "current_round": 220367, "lf_round": 220363} 2025-11-10T03:07:31.157Z DEBUG chain/entity.go:1714 found block to delete {"round": 220313, "block_round": 220069, "current_round": 220367, "lf_round": 220363} 2025-11-10T03:07:31.157Z DEBUG chain/entity.go:1714 found block to delete {"round": 220313, "block_round": 220070, "current_round": 220367, "lf_round": 220363} 2025-11-10T03:07:31.157Z DEBUG chain/entity.go:1714 found block to delete {"round": 220313, "block_round": 220071, "current_round": 220367, "lf_round": 220363} 2025-11-10T03:07:31.157Z DEBUG chain/protocol_round.go:334 finalize round - block has less than 3 confirmation 2025-11-10T03:07:31.157Z DEBUG chain/protocol_round.go:334 finalize round - block has less than 3 confirmation 2025-11-10T03:07:31.157Z DEBUG transaction/worker.go:253 [mvc] see no old txns {"clientID": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "nonce": 112401} 2025-11-10T03:07:31.157Z INFO chain/protocol_round.go:402 finalize round - finalize block success {"round": 220363, "block": "57254eec2972209c1019d35dc0db7d5f45bad3f67ed674427b3a52e45081f03a", "duration": "3.415728ms"} 2025-11-10T03:07:31.157Z INFO memorystore/collection.go:65 Redis returned 0 rows after seclect 2025-11-10T03:07:31.157Z DEBUG chain/worker.go:230 finalize block processed {"round": 220363, "duration": "3.381958ms"} 2025-11-10T03:07:31.157Z DEBUG chain/protocol_block.go:612 finalized block - done {"round": 220363, "block": "57254eec2972209c1019d35dc0db7d5f45bad3f67ed674427b3a52e45081f03a", "duration": "3.299877ms"} 2025-11-10T03:07:31.157Z INFO chain/entity.go:2366 config has been updated successfully {"start of round": 220363} 2025-11-10T03:07:31.156Z DEBUG transaction/worker.go:221 [mvc] remove old nonce txns {"clientID": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "nonce": 112401} 2025-11-10T03:07:31.156Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\ufffd\u001e\ufffd-7cq\u000e\ufffd\ufffdz\ufffdz\ufffd\ufffd\u0012\ufffdD\u001b\ufffdlj罦\ufffd\ufffd\u0003\ufffd'\ufffd}"} 2025-11-10T03:07:31.156Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "x\ufffdT\ufffd\\s\ufffdb\ufffda0\ufffdr\ufffd\u0002(\ufffdL\ufffd\u0006H\u0004\u0002TLH\ufffdf\u001cq/3"} 2025-11-10T03:07:31.156Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\ufffd1f\u000b\ufffd\ufffdq[\ufffd\ufffd\ufffd`)x\ufffd\ufffdw\ufffdj:\ufffdH\u0001\ufffd⩲\ufffd\ufffd\ufffd\ufffd\ufffd"} 2025-11-10T03:07:31.156Z INFO transaction/worker.go:164 cleaning transactions {"collection": "collection.txn:0afc093ffb509f059c55478bc1a60351cef7b4e9c008a53a6cc8241ca8617dfe", "missing_count": 1, "txns": ["81c69eb40ed82d5683f05712371ca94b6b69a8511de238208df6eec02475fe11"], "past txns": []} 2025-11-10T03:07:31.156Z INFO memorystore/collection.go:65 Redis returned 0 rows after seclect 2025-11-10T03:07:31.156Z DEBUG chain/worker.go:443 BC is moving {"current_lfb_round": 220363, "last_round": 220362} 2025-11-10T03:07:31.156Z DEBUG chain/lfb_round_node.go:33 [mvc] store lfb {"round": 220363, "block": "57254eec2972209c1019d35dc0db7d5f45bad3f67ed674427b3a52e45081f03a", "mb number": 1} 2025-11-10T03:07:31.156Z DEBUG chain/entity.go:2269 set lfb {"round": 220363, "block": "57254eec2972209c1019d35dc0db7d5f45bad3f67ed674427b3a52e45081f03a", "state_computed": true} 2025-11-10T03:07:31.156Z DEBUG transaction/worker.go:124 cleaning past transactions 2025-11-10T03:07:31.156Z DEBUG miner/round.go:238 Round clear - cancel verification 2025-11-10T03:07:31.156Z DEBUG chain/state.go:128 finalize round - rebased current state db {"round": 220363, "block": "57254eec2972209c1019d35dc0db7d5f45bad3f67ed674427b3a52e45081f03a", "state hash": "1d7839908c4d67094f059f3a0ca28159e481476d7d7a68cdf3946d83f98643ea"} 2025-11-10T03:07:31.156Z DEBUG util/mpt_nodedb.go:556 LevelNodeDB rebase db 2025-11-10T03:07:31.156Z DEBUG chain/protocol_block.go:424 finalize block - record dead nodes {"round": 220363, "block": "57254eec2972209c1019d35dc0db7d5f45bad3f67ed674427b3a52e45081f03a", "num dead nodes": 11} 2025-11-10T03:07:31.156Z DEBUG miner/chain.go:313 delete txns {"txns": ["81c69eb40ed82d5683f05712371ca94b6b69a8511de238208df6eec02475fe11"]} 2025-11-10T03:07:31.156Z INFO miner/protocol_block.go:619 update finalized block (debug transaction) {"txn": "81c69eb40ed82d5683f05712371ca94b6b69a8511de238208df6eec02475fe11", "block": "57254eec2972209c1019d35dc0db7d5f45bad3f67ed674427b3a52e45081f03a"} 2025-11-10T03:07:31.155Z INFO miner/protocol_block.go:613 update finalized block {"round": 220363, "block": "57254eec2972209c1019d35dc0db7d5f45bad3f67ed674427b3a52e45081f03a", "lf_round": 220362, "current_round": 220367, "weight": 1} 2025-11-10T03:07:31.155Z DEBUG chain/protocol_block.go:409 MPT state node stat - inc {"node num": -421039, "change num": 11, "delete num": 11} 2025-11-10T03:07:31.155Z INFO block/entity.go:1195 save state {"round": 220363, "block": "57254eec2972209c1019d35dc0db7d5f45bad3f67ed674427b3a52e45081f03a", "block_size": 1, "changes": 11, "client_state": "1d7839908c4d67094f059f3a0ca28159e481476d7d7a68cdf3946d83f98643ea", "duration": "1.748594ms"} 2025-11-10T03:07:31.155Z DEBUG util/merkle_patricia_trie.go:272 MPT save changes success {"duration": "1.26571ms"} 2025-11-10T03:07:31.155Z DEBUG util/mpt_node_change.go:156 MPT - update changes done {"changes": 11} 2025-11-10T03:07:31.154Z INFO miner/protocol_bls.go:489 Not yet reached threshold {"vrfShares_num": 1, "threshold": 2, "round": 220367} 2025-11-10T03:07:31.154Z DEBUG round/entity.go:684 add_vrf_share {"round": 220367, "round_vrf_num": 1, "threshold": 2} 2025-11-10T03:07:31.154Z INFO miner/protocol_bls.go:430 verified vrf {"round": 220367, "node_id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "share": "1 b09bb49b70a3b3ae766776a9db7c2f7f203f88f228089e7699d6fc7ad36fe04 e212111402dc54da1cd270cc7e64126c19033ea7e8f223ea7b9315652825686", "from": "196b96df7631e00d339f9a25131927c4", "message": "2203670719e4ec8ca26b0df"} 2025-11-10T03:07:31.154Z DEBUG util/mpt_node_change.go:150 MPT - update changes {"changes": 11} 2025-11-10T03:07:31.153Z DEBUG bls/dkg.go:396 dkg verify {"id": "196b96df7631e00d339f9a25131927c4", "key": "1 1f8c72cc3a6b74f6ad7528172b64afe3dc42ee1987495659fe2cf34e749caa7c 20957b4d25e7b5fb1e32d4e3b93e2b73dad7f118efb6dae28715e4ad627b0fff 14259a6ddf4b44c83c1389bd8ed1fc47c1b099c5986bb33923bbcbb25d30054a 2100bb7434dadde1a5ed8545748d0958955bcd21e06cf170f78dbda35a9e04b7", "msg": "2203670719e4ec8ca26b0df", "sig": "1 b09bb49b70a3b3ae766776a9db7c2f7f203f88f228089e7699d6fc7ad36fe04 e212111402dc54da1cd270cc7e64126c19033ea7e8f223ea7b9315652825686"} 2025-11-10T03:07:31.153Z INFO miner/protocol_bls.go:265 BLS sign VRF share calculated for {"round": 220367, "round_timeout": 0, "prev_rseed": 8187067796898099423, "prev round vrf random seed": "719e4ec8ca26b0df", "bls_msg": "2203670719e4ec8ca26b0df"} 2025-11-10T03:07:31.153Z INFO miner/protocol_bls.go:364 DKG AddVRFShare {"round": 220367, "round_vrf_num": 0, "threshold": 2, "sender": 1, "round_timeout_count": 0, "vrf_timeout_count": 0, "vrf_share": "1 b09bb49b70a3b3ae766776a9db7c2f7f203f88f228089e7699d6fc7ad36fe04 e212111402dc54da1cd270cc7e64126c19033ea7e8f223ea7b9315652825686"} 2025-11-10T03:07:31.153Z INFO miner/protocol_round.go:78 add_my_vrf_share {"round": 220367, "round_timeout": 0, "dkg_starting_round": 0, "dkg_mb_number": 1, "pr_seed": 8187067796898099423, "pr_vrf_seed": "719e4ec8ca26b0df", "share": "1 b09bb49b70a3b3ae766776a9db7c2f7f203f88f228089e7699d6fc7ad36fe04 e212111402dc54da1cd270cc7e64126c19033ea7e8f223ea7b9315652825686"} 2025-11-10T03:07:31.153Z DEBUG miner/protocol_bls.go:305 get_bls_share {"round": 220367, "rtc": 0, "dkg_pi": "1 1f8c72cc3a6b74f6ad7528172b64afe3dc42ee1987495659fe2cf34e749caa7c 20957b4d25e7b5fb1e32d4e3b93e2b73dad7f118efb6dae28715e4ad627b0fff 14259a6ddf4b44c83c1389bd8ed1fc47c1b099c5986bb33923bbcbb25d30054a 2100bb7434dadde1a5ed8545748d0958955bcd21e06cf170f78dbda35a9e04b7", "dkg_sr": 0, "mb_sr": 0, "share": "1 b09bb49b70a3b3ae766776a9db7c2f7f203f88f228089e7699d6fc7ad36fe04 e212111402dc54da1cd270cc7e64126c19033ea7e8f223ea7b9315652825686"} 2025-11-10T03:07:31.153Z INFO round/entity.go:618 get miners by rank {"num_miners": 3, "round": 220363, "r.minerPerm": [1, 2, 0]} 2025-11-10T03:07:31.153Z INFO chain/protocol_block.go:363 finalize block -- round {"round": {"number":220363,"round_random_seed":-7588150263849208320,"block_hash":"57254eec2972209c1019d35dc0db7d5f45bad3f67ed674427b3a52e45081f03a","vrf_output":"96b17989ecfb360035cbd783b05fb196f33e0c8754d1837a392bb58003050d0d"}, "block": "57254eec2972209c1019d35dc0db7d5f45bad3f67ed674427b3a52e45081f03a"} 2025-11-10T03:07:31.153Z INFO chain/protocol_block.go:328 finalize block {"round": 220363, "current_round": 220367, "lf_round": 220362, "hash": "57254eec2972209c1019d35dc0db7d5f45bad3f67ed674427b3a52e45081f03a", "round_rank": 0, "state": 7} 2025-11-10T03:07:31.153Z DEBUG chain/worker.go:262 start to finalize block {"round": 220363, "block": "57254eec2972209c1019d35dc0db7d5f45bad3f67ed674427b3a52e45081f03a", "prev block": "f494fe8228601f796fb30df241995eebf3afbafdba9ed4ea0b79183252d6fc34"} 2025-11-10T03:07:31.153Z INFO chain/protocol_round.go:359 finalize round {"round": 220363, "lfb round": 220365, "block": "57254eec2972209c1019d35dc0db7d5f45bad3f67ed674427b3a52e45081f03a"} 2025-11-10T03:07:31.153Z INFO chain/protocol_round.go:326 finalize round - latest finalized round {"round": 220366, "lfb round": 220365, "lfb block": "d1908c8dca3d93b96877cd4a747d69891898951bc599b2a584e58c5907e29b69"} 2025-11-10T03:07:31.153Z INFO chain/protocol_round.go:199 finalize round {"round": 220366, "plfb_round": 220362, "num_round_notarized": 1, "num_chain_notarized": 3} 2025-11-10T03:07:31.153Z DEBUG chain/protocol_round.go:160 finalize round {"round": 220366, "lf_round": 220362} 2025-11-10T03:07:31.153Z DEBUG bls/dkg.go:356 dkg sign {"key": "1ef4cd5ccbeb2dfce1247caae9b2222f43537288563d8624eeb7f5102005c109", "pi": "1 1f8c72cc3a6b74f6ad7528172b64afe3dc42ee1987495659fe2cf34e749caa7c 20957b4d25e7b5fb1e32d4e3b93e2b73dad7f118efb6dae28715e4ad627b0fff 14259a6ddf4b44c83c1389bd8ed1fc47c1b099c5986bb33923bbcbb25d30054a 2100bb7434dadde1a5ed8545748d0958955bcd21e06cf170f78dbda35a9e04b7"} 2025-11-10T03:07:31.153Z DEBUG miner/protocol_bls.go:293 Sign msg with dkg {"msg": "2203670719e4ec8ca26b0df", "round": 220367, "dkg starting round": 0} 2025-11-10T03:07:31.153Z INFO miner/protocol_bls.go:265 BLS sign VRF share calculated for {"round": 220367, "round_timeout": 0, "prev_rseed": 8187067796898099423, "prev round vrf random seed": "719e4ec8ca26b0df", "bls_msg": "2203670719e4ec8ca26b0df"} 2025-11-10T03:07:31.153Z INFO miner/protocol_bls.go:283 DKG getBlsShare {"Round Number": 220367} 2025-11-10T03:07:31.153Z INFO miner/protocol_round.go:244 StartNextRound - add VRF {"round": 220367} 2025-11-10T03:07:31.153Z INFO miner/round.go:40 Try to cancel block generation that have not been started yet {"round": 220366} 2025-11-10T03:07:31.153Z DEBUG miner/protocol_round.go:210 finalizedRound - cancel round verification {"round": 220366} 2025-11-10T03:07:31.153Z INFO chain/entity.go:2016 Moving to the next round {"next_round": 220367} 2025-11-10T03:07:31.153Z DEBUG miner/protocol_round.go:154 [wait not ahead] [2] not ahead, can move on {"round": 220366, "lfb tk round": 220362} 2025-11-10T03:07:31.153Z DEBUG miner/protocol_round.go:123 [wait not ahead] 2025-11-10T03:07:31.153Z DEBUG miner/protocol_round.go:991 verification_complete {"top_verified_rank": 0} 2025-11-10T03:07:31.153Z INFO miner/protocol_round.go:986 verification_complete {"round": 220366, "verified_blocks": 0} 2025-11-10T03:07:31.153Z DEBUG miner/protocol_round.go:943 verifyAndSend - finished successfully {"round": 220366, "block": "590839da3aaffc06479d7d48fc9e523f958edee0826341a3e3e0f59b2532b1d2"} 2025-11-10T03:07:31.153Z INFO miner/round.go:40 Try to cancel block generation that have not been started yet {"round": 220366} 2025-11-10T03:07:31.153Z INFO miner/round.go:230 Cancelling verification {"round": 220366} 2025-11-10T03:07:31.153Z INFO miner/protocol_receive.go:456 process notarization - start next round {"new round": 220367} 2025-11-10T03:07:31.153Z DEBUG miner/protocol_round.go:1149 check block notarization - block notarized {"round": 220366, "block": "590839da3aaffc06479d7d48fc9e523f958edee0826341a3e3e0f59b2532b1d2"} 2025-11-10T03:07:31.153Z DEBUG round/entity.go:344 reached notarization {"round": 220366} 2025-11-10T03:07:31.153Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 220366, "randk": 0, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T03:07:31.153Z INFO chain/entity.go:1571 Adding a notarized block for current round {"Round": 220366} 2025-11-10T03:07:31.153Z INFO chain/protocol_block.go:303 reached notarization - add tickets {"round": 220366, "current_round": 220366, "block": "590839da3aaffc06479d7d48fc9e523f958edee0826341a3e3e0f59b2532b1d2", "tickets_num": 2} 2025-11-10T03:07:31.153Z INFO miner/protocol_round.go:920 verifyAndSend - sending verification ticket {"round": 220366, "block": "590839da3aaffc06479d7d48fc9e523f958edee0826341a3e3e0f59b2532b1d2", "block_rank": 0, "RRS": 8187067796898099423} 2025-11-10T03:07:31.153Z INFO chain/protocol_block.go:319 reached notarization - merging tickets {"round": 220365, "current_round": 220366, "block": "d1908c8dca3d93b96877cd4a747d69891898951bc599b2a584e58c5907e29b69", "tickets_num": 3} 2025-11-10T03:07:31.153Z DEBUG miner/protocol_round.go:1069 verify round block - finished verification {"block": "590839da3aaffc06479d7d48fc9e523f958edee0826341a3e3e0f59b2532b1d2"} 2025-11-10T03:07:31.153Z INFO miner/protocol_block.go:376 verify block successful {"round": 220366, "block_size": 2, "time": "14.291557ms", "block": "590839da3aaffc06479d7d48fc9e523f958edee0826341a3e3e0f59b2532b1d2", "prev_block": "d1908c8dca3d93b96877cd4a747d69891898951bc599b2a584e58c5907e29b69", "state_hash": "e0ffde27bfe8e4534fa2699958a648688216af4da56f67d45070bedaa036b89b", "state_status": 4} 2025-11-10T03:07:31.153Z DEBUG miner/protocol_block.go:374 SignBlock finished {"block": "590839da3aaffc06479d7d48fc9e523f958edee0826341a3e3e0f59b2532b1d2", "spent": "101.001µs"} 2025-11-10T03:07:31.152Z DEBUG miner/protocol_block.go:367 VerifyBlockMagicBlock finished {"block": "590839da3aaffc06479d7d48fc9e523f958edee0826341a3e3e0f59b2532b1d2", "spent": "360ns"} 2025-11-10T03:07:31.152Z DEBUG miner/protocol_block.go:360 verifySmartContracts finished {"block": "590839da3aaffc06479d7d48fc9e523f958edee0826341a3e3e0f59b2532b1d2", "spent": "3.01µs"} 2025-11-10T03:07:31.152Z DEBUG miner/protocol_block.go:351 verify block - ComputeState finished {"round": 220366, "block": "590839da3aaffc06479d7d48fc9e523f958edee0826341a3e3e0f59b2532b1d2", "spent": "9.447717ms"} 2025-11-10T03:07:31.152Z INFO block/entity.go:1034 compute state successful {"round": 220366, "block": "590839da3aaffc06479d7d48fc9e523f958edee0826341a3e3e0f59b2532b1d2", "block ptr": "0xc016545860", "block_size": 2, "duration": "9.401137ms", "changes": 12, "begin_client_state": "16e321ae08596f08b94ea91000f378f273f3086a925e62deb79f98699363f309", "computed_state_hash": "e0ffde27bfe8e4534fa2699958a648688216af4da56f67d45070bedaa036b89b", "block_state_hash": "e0ffde27bfe8e4534fa2699958a648688216af4da56f67d45070bedaa036b89b", "prev_block": "d1908c8dca3d93b96877cd4a747d69891898951bc599b2a584e58c5907e29b69", "prev_block_client_state": "16e321ae08596f08b94ea91000f378f273f3086a925e62deb79f98699363f309"} 2025-11-10T03:07:31.152Z DEBUG statecache/statecache.go:131 statecache - commit {"block": "590839da3aaffc06479d7d48fc9e523f958edee0826341a3e3e0f59b2532b1d2", "bc_hits": 81, "bc_miss": 0, "sc_hits": 20104401, "sc_miss": 6214, "duration": "263.772µs"} 2025-11-10T03:07:31.152Z DEBUG chain/state.go:961 Updating nonce {"client": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "new_nonce": 113387} 2025-11-10T03:07:31.151Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T03:07:31.151Z INFO chain/state.go:533 SC executed {"client id": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "block": "590839da3aaffc06479d7d48fc9e523f958edee0826341a3e3e0f59b2532b1d2", "round": 220366, "prev_state_hash": "16e321ae08596f08b94ea91000f378f273f3086a925e62deb79f98699363f309", "txn_hash": "b010f6816087cea864b94f2b30fc1afef3f6686c0fa17a34761c75407a34acca", "txn_nonce": 113387, "txn_func": "generate_challenge", "txn_status": 1, "txn_exec_time": "238.572µs", "begin client state": "bc76ba1c0eb0bec2d3854dda50e23978bfd902adf80dc0c6fb64283514d98f08", "current_root": "bc76ba1c0eb0bec2d3854dda50e23978bfd902adf80dc0c6fb64283514d98f08", "mpt_cache_hit": 10, "mpt_cache_miss": 0, "output": "OpenChallenges generated"} 2025-11-10T03:07:31.151Z INFO storagesc/challenge.go:1191 skipping generate challenge: empty blobber challenge partition 2025-11-10T03:07:31.151Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "eaf4195ad8a6c0bd8f90e9b28f4ba3b4938ddc60155952285997f669446bb502"} 2025-11-10T03:07:31.151Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T03:07:31.150Z DEBUG chain/state.go:961 Updating nonce {"client": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "new_nonce": 113386} 2025-11-10T03:07:31.150Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T03:07:31.150Z INFO chain/state.go:533 SC executed {"client id": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "block": "590839da3aaffc06479d7d48fc9e523f958edee0826341a3e3e0f59b2532b1d2", "round": 220366, "prev_state_hash": "16e321ae08596f08b94ea91000f378f273f3086a925e62deb79f98699363f309", "txn_hash": "8f6469580f28d537079cebb29116ecd26f3e281c4d363b0a15970442fc0c4b9c", "txn_nonce": 113386, "txn_func": "payFees", "txn_status": 1, "txn_exec_time": "6.622055ms", "begin client state": "16e321ae08596f08b94ea91000f378f273f3086a925e62deb79f98699363f309", "current_root": "24aaa9072fc42302bfc163e428677c765018d3ee39c0177855b7456cfb2d03cd", "mpt_cache_hit": 45, "mpt_cache_miss": 0, "output": ""} 2025-11-10T03:07:31.149Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T03:07:31.149Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T03:07:31.149Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T03:07:31.148Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T03:07:31.144Z ERROR minersc/global_node.go:372 failed to get current magic block {"error": "value not present"} 2025-11-10T03:07:31.144Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "6dba10422e368813802877a85039d3985d96760ed844092319743fb3a76712d9d2208fe938b7465b9c5dc571053986cf8dbf3585fb36399f98ea569c42f50b76"} 2025-11-10T03:07:31.144Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "6dba10422e368813802877a85039d3985d96760ed844092319743fb3a76712d9b5e8a1650666fdd3a9de7855b6da63ab629b1701f23738477e2325f7ca2150ac"} 2025-11-10T03:07:31.144Z DEBUG minersc/fees.go:480 pay_fees, got miner id successfully {"miner id": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "round": 220366, "block": "590839da3aaffc06479d7d48fc9e523f958edee0826341a3e3e0f59b2532b1d2"} 2025-11-10T03:07:31.143Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T03:07:31.143Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T03:07:31.143Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T03:07:31.143Z DEBUG miner/protocol_block.go:339 ValidateBlockCost {"round": 220366, "hash": "590839da3aaffc06479d7d48fc9e523f958edee0826341a3e3e0f59b2532b1d2", "calculated cost": 100} 2025-11-10T03:07:31.143Z DEBUG statecache/statecache.go:173 state cache - see gap {"block": "882f02d1a21ff33e5869b48b22636ae9e347097a5f2a60fe17bc24c417618cf2"}