2025-11-10T00:49:27.999Z DEBUG miner/protocol_block.go:292 VerifyBlockMagicBlockReference finished {"block": "80c9870add157563071ac35c8b728ea7eee4075419ca3cf053d4c751ab9bec42", "spent": "3.59µs"} 2025-11-10T00:49:27.999Z DEBUG miner/protocol_block.go:286 Validating finished {"block": "80c9870add157563071ac35c8b728ea7eee4075419ca3cf053d4c751ab9bec42", "spent": "924.104µs"} 2025-11-10T00:49:27.998Z DEBUG miner/protocol_round.go:1067 verify round block - started verification {"block": "80c9870add157563071ac35c8b728ea7eee4075419ca3cf053d4c751ab9bec42"} 2025-11-10T00:49:27.998Z DEBUG miner/protocol_round.go:1040 verify round block {"round": 179698, "block": "80c9870add157563071ac35c8b728ea7eee4075419ca3cf053d4c751ab9bec42"} 2025-11-10T00:49:27.998Z DEBUG miner/protocol_round.go:865 verifyAndSend - started {"block": "80c9870add157563071ac35c8b728ea7eee4075419ca3cf053d4c751ab9bec42"} 2025-11-10T00:49:27.998Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 179698, "randk": 1, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T00:49:27.998Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 179698, "randk": 0, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T00:49:27.998Z INFO miner/protocol_round.go:951 Started main verification loop {"round": 179698} 2025-11-10T00:49:27.998Z DEBUG miner/worker.go:53 message {"msg": {"code":"verification_ticket","value":"Verification Ticket"}, "sender_index": 0, "id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341"} 2025-11-10T00:49:27.997Z DEBUG miner/m_handler.go:365 handle vt. msg - verification ticket {"round": 179698, "block": "80c9870add157563071ac35c8b728ea7eee4075419ca3cf053d4c751ab9bec42"} 2025-11-10T00:49:27.992Z DEBUG chain/entity.go:440 process block, no block in buffer {"current round": 179698} 2025-11-10T00:49:27.896Z DEBUG chain/protocol_lfb_ticket.go:386 update lfb ticket - ticket.Round <= latest.Round {"ticket.Round": 179694, "latest.Round": 179694} 2025-11-10T00:49:27.891Z DEBUG chain/entity.go:440 process block, no block in buffer {"current round": 179698} 2025-11-10T00:49:27.871Z DEBUG chain/protocol_lfb_ticket.go:386 update lfb ticket - ticket.Round <= latest.Round {"ticket.Round": 179694, "latest.Round": 179694} 2025-11-10T00:49:27.839Z DEBUG miner/protocol_round.go:1028 verify block - pending {"round": 179698, "block": "f7655e1c02407d7226a4e61dbf09a3c9f8b08561be24914c9458c78852b7eaaf"} 2025-11-10T00:49:27.839Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 179698, "randk": 1, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T00:49:27.839Z DEBUG miner/round.go:143 Adding block to verifyChannel {"round": 179698, "block hash": "f7655e1c02407d7226a4e61dbf09a3c9f8b08561be24914c9458c78852b7eaaf", "magic block": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "magic block round": 0} 2025-11-10T00:49:27.839Z INFO miner/protocol_round.go:803 adding block to verify {"round": 179698, "block": "f7655e1c02407d7226a4e61dbf09a3c9f8b08561be24914c9458c78852b7eaaf", "prev_block": "7086923e0045bf4137778c39dd21dc307cda9a8f9c6581a7eab1608203fb852d", "state_hash": "4588d8d4d6b8ca4c06664c16d794183488d6222cbd14ee27989c832da6d2f9d4", "weight": 0.5} 2025-11-10T00:49:27.839Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 179698, "randk": 1, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T00:49:27.839Z DEBUG statecache/statecache.go:131 statecache - commit {"block": "f7655e1c02407d7226a4e61dbf09a3c9f8b08561be24914c9458c78852b7eaaf", "bc_hits": 81, "bc_miss": 0, "sc_hits": 16632601, "sc_miss": 4957, "duration": "487.957µs"} 2025-11-10T00:49:27.839Z INFO miner/protocol_block.go:1316 generate block (assemble+update+sign) {"round": 179698, "block_size": 2, "reused_txns": 0, "reused_txns": 0, "time": "20.845814ms", "block": "f7655e1c02407d7226a4e61dbf09a3c9f8b08561be24914c9458c78852b7eaaf", "prev_block": "7086923e0045bf4137778c39dd21dc307cda9a8f9c6581a7eab1608203fb852d", "begin_state_hash": "851e21808cf53bab5e8cb5ee594529f3022dddd114d001b36ab87f14ba611c84", "block_state_hash": "4588d8d4d6b8ca4c06664c16d794183488d6222cbd14ee27989c832da6d2f9d4", "computed_state_hash": "4588d8d4d6b8ca4c06664c16d794183488d6222cbd14ee27989c832da6d2f9d4", "changes": 12, "state_status": 4, "iteration_count": 0} 2025-11-10T00:49:27.838Z DEBUG miner/protocol_block.go:1305 generate block (assemble+update) {"round": 179698, "txns": 2, "time": "20.533539ms"} 2025-11-10T00:49:27.838Z DEBUG miner/protocol_block.go:1282 generate block (assemble) {"round": 179698, "txns": 2, "time": "20.460938ms"} 2025-11-10T00:49:27.837Z DEBUG chain/state.go:961 Updating nonce {"client": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "new_nonce": 92495} 2025-11-10T00:49:27.837Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T00:49:27.837Z INFO chain/state.go:533 SC executed {"client id": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "block": "", "round": 179698, "prev_state_hash": "851e21808cf53bab5e8cb5ee594529f3022dddd114d001b36ab87f14ba611c84", "txn_hash": "98a2222c381e007134a4fc4226e8ca2e2035b88467e0b6869d98ae87710aca9e", "txn_nonce": 92495, "txn_func": "generate_challenge", "txn_status": 0, "txn_exec_time": "394.066µs", "begin client state": "838186c5932e85ecae1fd4d8e2a320b56579d68f6553bbb1b0ac074da45e2f9a", "current_root": "838186c5932e85ecae1fd4d8e2a320b56579d68f6553bbb1b0ac074da45e2f9a", "mpt_cache_hit": 10, "mpt_cache_miss": 0, "output": "OpenChallenges generated"} 2025-11-10T00:49:27.837Z INFO storagesc/challenge.go:1191 skipping generate challenge: empty blobber challenge partition 2025-11-10T00:49:27.837Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "eaf4195ad8a6c0bd8f90e9b28f4ba3b4938ddc60155952285997f669446bb502"} 2025-11-10T00:49:27.836Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T00:49:27.836Z DEBUG chain/protocol_view_change.go:424 [mvc] nonce, set nonce in getCurrentSelfNonce {"nonce": 92494} 2025-11-10T00:49:27.836Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T00:49:27.836Z DEBUG chain/protocol_view_change.go:431 [mvc] nonce, get current miner nonce {"minerId": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea"} 2025-11-10T00:49:27.835Z DEBUG chain/state.go:961 Updating nonce {"client": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "new_nonce": 92494} 2025-11-10T00:49:27.834Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T00:49:27.834Z INFO chain/state.go:533 SC executed {"client id": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "block": "", "round": 179698, "prev_state_hash": "851e21808cf53bab5e8cb5ee594529f3022dddd114d001b36ab87f14ba611c84", "txn_hash": "7e193b3b0a7fec8e669a32b38f72836ad9615272c3611c5624681e9e1b273252", "txn_nonce": 92494, "txn_func": "payFees", "txn_status": 0, "txn_exec_time": "12.015115ms", "begin client state": "851e21808cf53bab5e8cb5ee594529f3022dddd114d001b36ab87f14ba611c84", "current_root": "6e4ba19c562d9526994f3422682e27ceb6b4aae87e4859ad9be200971c295e59", "mpt_cache_hit": 45, "mpt_cache_miss": 0, "output": ""} 2025-11-10T00:49:27.833Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T00:49:27.833Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T00:49:27.832Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T00:49:27.832Z DEBUG miner/protocol_round.go:1028 verify block - pending {"round": 179698, "block": "80c9870add157563071ac35c8b728ea7eee4075419ca3cf053d4c751ab9bec42"} 2025-11-10T00:49:27.832Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 179698, "randk": 0, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T00:49:27.832Z DEBUG miner/protocol_receive.go:130 verify block processed {"round": 179698, "block": "80c9870add157563071ac35c8b728ea7eee4075419ca3cf053d4c751ab9bec42"} 2025-11-10T00:49:27.832Z DEBUG miner/round.go:143 Adding block to verifyChannel {"round": 179698, "block hash": "80c9870add157563071ac35c8b728ea7eee4075419ca3cf053d4c751ab9bec42", "magic block": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "magic block round": 0} 2025-11-10T00:49:27.832Z DEBUG miner/protocol_round.go:759 update prev block notarization, already notarized {"round": 179697, "block": "7086923e0045bf4137778c39dd21dc307cda9a8f9c6581a7eab1608203fb852d"} 2025-11-10T00:49:27.832Z INFO miner/protocol_round.go:803 adding block to verify {"round": 179698, "block": "80c9870add157563071ac35c8b728ea7eee4075419ca3cf053d4c751ab9bec42", "prev_block": "7086923e0045bf4137778c39dd21dc307cda9a8f9c6581a7eab1608203fb852d", "state_hash": "34674538ebfece4005c1637246261067efc721bcab2fe702bd2e594836e3dac6", "weight": 1} 2025-11-10T00:49:27.832Z INFO miner/protocol_round.go:613 handle verify block - added block for ticket verification {"round": 179698, "block": "80c9870add157563071ac35c8b728ea7eee4075419ca3cf053d4c751ab9bec42", "magic block": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "magic block round": 0} 2025-11-10T00:49:27.832Z INFO chain/protocol_block.go:225 not reached notarization {"mb_sr": 0, "active_miners": 3, "threshold": 2, "num_signatures": 0, "current_round": 179698, "round": 179698} 2025-11-10T00:49:27.832Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T00:49:27.831Z DEBUG miner/protocol_receive.go:169 verify block {"round": 179698, "block": "80c9870add157563071ac35c8b728ea7eee4075419ca3cf053d4c751ab9bec42"} 2025-11-10T00:49:27.831Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"verify_block","value":"Verify Block"}, "sender_index": 0, "id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "duration": "71.141µs"} 2025-11-10T00:49:27.831Z DEBUG miner/worker.go:53 message {"msg": {"code":"verify_block","value":"Verify Block"}, "sender_index": 0, "id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341"} 2025-11-10T00:49:27.823Z ERROR minersc/global_node.go:372 failed to get current magic block {"error": "value not present"} 0chain.net/smartcontract/minersc.(*GlobalNode).prevMagicBlock /0chain/code/go/0chain.net/smartcontract/minersc/global_node.go:372 0chain.net/smartcontract/minersc.getRegisterShardersInMagicBlock /0chain/code/go/0chain.net/smartcontract/minersc/fees.go:659 0chain.net/smartcontract/minersc.(*MinerSmartContract).payFees /0chain/code/go/0chain.net/smartcontract/minersc/fees.go:519 0chain.net/smartcontract/minersc.(*MinerSmartContract).Execute /0chain/code/go/0chain.net/smartcontract/minersc/sc.go:139 0chain.net/chaincore/smartcontract.ExecuteWithStats /0chain/code/go/0chain.net/chaincore/smartcontract/handler.go:52 0chain.net/chaincore/smartcontract.ExecuteSmartContract /0chain/code/go/0chain.net/chaincore/smartcontract/handler.go:67 0chain.net/chaincore/chain.(*Chain).ExecuteSmartContract.func1 /0chain/code/go/0chain.net/chaincore/chain/state.go:158 2025-11-10T00:49:27.823Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "6dba10422e368813802877a85039d3985d96760ed844092319743fb3a76712d9d2208fe938b7465b9c5dc571053986cf8dbf3585fb36399f98ea569c42f50b76"} 2025-11-10T00:49:27.822Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "6dba10422e368813802877a85039d3985d96760ed844092319743fb3a76712d9b5e8a1650666fdd3a9de7855b6da63ab629b1701f23738477e2325f7ca2150ac"} 2025-11-10T00:49:27.822Z DEBUG minersc/fees.go:480 pay_fees, got miner id successfully {"miner id": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "round": 179698, "block": ""} 2025-11-10T00:49:27.822Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T00:49:27.822Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T00:49:27.821Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T00:49:27.821Z DEBUG chain/protocol_view_change.go:424 [mvc] nonce, set nonce in getCurrentSelfNonce {"nonce": 92493} 2025-11-10T00:49:27.821Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "1\ufffd\ufffd\ufffdb\ufffd4\ufffd\u0018\ufffd]f\u0017\ufffd\ufffd\ufffd\ufffdS\ufffdn\ufffd\ufffd\u0014\ufffd=XH\ufffd\ufffd\u0017(\ufffd"} 2025-11-10T00:49:27.821Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "D\ufffdb&6c\ufffd\ufffd\ufffds\ufffd)z\ufffd\ufffd%|F\ufffd\u001a\ufffd3k\u00119\u0013\ufffdf\ufffd\ufffd\ufffd\ufffdݬ)\u0010u"} 2025-11-10T00:49:27.820Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\ufffd\u001e!\ufffd\ufffd\ufffd;\ufffd^\ufffd\ufffd\ufffdYE)\ufffd\u0002-\ufffd\ufffd\u0014\ufffd\u0001\ufffdj\ufffd\u0014\ufffda\u001c\ufffd"} 2025-11-10T00:49:27.820Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T00:49:27.820Z DEBUG chain/protocol_view_change.go:431 [mvc] nonce, get current miner nonce {"minerId": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea"} 2025-11-10T00:49:27.820Z INFO memorystore/collection.go:65 Redis returned 0 rows after seclect 2025-11-10T00:49:27.820Z INFO miner/protocol_block.go:1112 generate block starting iteration {"round": 179698, "prev_block": "7086923e0045bf4137778c39dd21dc307cda9a8f9c6581a7eab1608203fb852d", "prev_state_hash": "851e21808cf53bab5e8cb5ee594529f3022dddd114d001b36ab87f14ba611c84"} 2025-11-10T00:49:27.820Z DEBUG statecache/statecache.go:173 state cache - see gap {"block": "0a1d0709e7b36484236f49ba15512201289834420ea9115ff09c91df3763330c"} 2025-11-10T00:49:27.819Z DEBUG statecache/statecache.go:173 state cache - see gap {"block": "0a1d0709e7b36484236f49ba15512201289834420ea9115ff09c91df3763330c"} 2025-11-10T00:49:27.819Z INFO miner/protocol_bls.go:481 DKG ThresholdNumSigReceived VRF is already completed. {"round": 179698} 2025-11-10T00:49:27.819Z INFO round/entity.go:675 add_vrf_share already at threshold. Returning false. 2025-11-10T00:49:27.819Z INFO miner/protocol_bls.go:430 verified vrf {"round": 179698, "node_id": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "share": "1 1d4ef0bea35be49e4f76ae89965396571760577f13b0432b547f78323d42171d 13e74e8131136382089ae15a39a6ec34edee01b18fb56e017586c71938c7f29d", "from": "1c3227e496fdf3c9aa604f3470a2bbd1", "message": "179698014abb95ddad6e60"} 2025-11-10T00:49:27.819Z DEBUG statecache/statecache.go:173 state cache - see gap {"block": "0a1d0709e7b36484236f49ba15512201289834420ea9115ff09c91df3763330c"} 2025-11-10T00:49:27.819Z DEBUG statecache/statecache.go:173 state cache - see gap {"block": "0a1d0709e7b36484236f49ba15512201289834420ea9115ff09c91df3763330c"} 2025-11-10T00:49:27.819Z INFO chain/entity.go:1721 delete blocks below round {"round": 179698, "below_round": 179645, "before": 1762735707, "total": 311, "count": 0} 2025-11-10T00:49:27.819Z DEBUG chain/protocol_round.go:334 finalize round - block has less than 3 confirmation 2025-11-10T00:49:27.819Z DEBUG chain/protocol_round.go:334 finalize round - block has less than 3 confirmation 2025-11-10T00:49:27.819Z INFO chain/protocol_round.go:326 finalize round - latest finalized round {"round": 179697, "lfb round": 179696, "lfb block": "14482f721677a955910a55bd0cdd44f655d2497180061be5d9cd6ae0f187c922"} 2025-11-10T00:49:27.818Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"vrf_share","value":"VRF Share"}, "sender_index": 0, "id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "duration": "2.73942ms"} 2025-11-10T00:49:27.819Z INFO chain/protocol_round.go:199 finalize round {"round": 179697, "plfb_round": 179694, "num_round_notarized": 1, "num_chain_notarized": 3} 2025-11-10T00:49:27.818Z INFO chain/entity.go:1721 delete blocks below round {"round": 179698, "below_round": 179644, "before": 1762735707, "total": 311, "count": 0} 2025-11-10T00:49:27.818Z DEBUG chain/protocol_round.go:334 finalize round - block has less than 3 confirmation 2025-11-10T00:49:27.818Z DEBUG chain/protocol_round.go:334 finalize round - block has less than 3 confirmation 2025-11-10T00:49:27.818Z DEBUG chain/worker.go:230 finalize block processed {"round": 179694, "duration": "4.358484ms"} 2025-11-10T00:49:27.818Z INFO chain/protocol_round.go:402 finalize round - finalize block success {"round": 179694, "block": "871c64a36a39760e08b1e5a33c7daff8c82e789f28f5943382521c786e2239c6", "duration": "4.411825ms"} 2025-11-10T00:49:27.818Z INFO miner/protocol_bls.go:481 DKG ThresholdNumSigReceived VRF is already completed. {"round": 179698} 2025-11-10T00:49:27.818Z DEBUG statecache/statecache.go:173 state cache - see gap {"block": "0a1d0709e7b36484236f49ba15512201289834420ea9115ff09c91df3763330c"} 2025-11-10T00:49:27.818Z INFO round/entity.go:675 add_vrf_share already at threshold. Returning false. 2025-11-10T00:49:27.818Z DEBUG chain/protocol_block.go:612 finalized block - done {"round": 179694, "block": "871c64a36a39760e08b1e5a33c7daff8c82e789f28f5943382521c786e2239c6", "duration": "4.155681ms"} 2025-11-10T00:49:27.818Z DEBUG bls/dkg.go:396 dkg verify {"id": "1c3227e496fdf3c9aa604f3470a2bbd1", "key": "1 6603e20478fac2c72a61b85056977b92696b8fffd408d8acac0e1f47aed3f96 1501242ed9000d9c6a02764160261164a52360a692c34ed452ff097bc90ee9b3 7f8aaa178d31fa4cbd0c1974768dfa4921e29405754ebf8d2c163a774b741a2 24515e04bd685a5559260f5d1868e5ea11abaf21f55a56aee52c15d9f3c2b053", "msg": "179698014abb95ddad6e60", "sig": "1 1d4ef0bea35be49e4f76ae89965396571760577f13b0432b547f78323d42171d 13e74e8131136382089ae15a39a6ec34edee01b18fb56e017586c71938c7f29d"} 2025-11-10T00:49:27.818Z INFO chain/entity.go:2366 config has been updated successfully {"start of round": 179694} 2025-11-10T00:49:27.818Z DEBUG statecache/statecache.go:173 state cache - see gap {"block": "0a1d0709e7b36484236f49ba15512201289834420ea9115ff09c91df3763330c"} 2025-11-10T00:49:27.818Z INFO miner/protocol_bls.go:430 verified vrf {"round": 179698, "node_id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "share": "1 1c1d9f724f3dc3d029455a9032726470ab868a7c159097c3ed395b6463556c20 d18753ddd5beaaa745966f89127607809bbbc6a6915bccd647d686be73f4af5", "from": "196b96df7631e00d339f9a25131927c4", "message": "179698014abb95ddad6e60"} 2025-11-10T00:49:27.818Z 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-10T00:49:27.818Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 179698, "randk": 1, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T00:49:27.818Z INFO miner/protocol_round.go:830 Starting round verification {"round": 179698, "delta": "180ms"} 2025-11-10T00:49:27.818Z DEBUG miner/protocol_round.go:467 Setting LFMB round/hash for a block {"rn": 179698, "mc.crn": 179698, "rnoff": 179673, "nvc": 0, "r": 0, "h": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "b.lfmbr": 0, "b.lfmbh": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4"} 2025-11-10T00:49:27.818Z INFO round/entity.go:618 get miners by rank {"num_miners": 3, "round": 179698, "r.minerPerm": [2, 0, 1]} 2025-11-10T00:49:27.818Z DEBUG transaction/worker.go:253 [mvc] see no old txns {"clientID": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "nonce": 92492} 2025-11-10T00:49:27.818Z INFO memorystore/collection.go:65 Redis returned 0 rows after seclect 2025-11-10T00:49:27.818Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\ufffd-<1n\ufffd\ufffdD\ufffd\ufffdå\ufffd\u0017\ufffd\t\ufffd\u001eE\ufffd]\ufffd\ufffd\u0001\ufffd\ufffdƈ;\ufffdx"} 2025-11-10T00:49:27.818Z INFO miner/protocol_round.go:340 *** TOC_FIX starting round block generation *** {"round": 179698, "index": 2, "rank": 1, "timeout_count": 0, "random_seed": 2638710386037467031, "lf_round": 179694} 2025-11-10T00:49:27.818Z INFO miner/protocol_bls.go:591 Starting round with vrf {"round": 179698, "roundtimeout": 0, "rseed": 2638710386037467031, "prev_round": 179697, "Prev_rseed": 0} 2025-11-10T00:49:27.818Z DEBUG transaction/worker.go:221 [mvc] remove old nonce txns {"clientID": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "nonce": 92492} 2025-11-10T00:49:27.818Z DEBUG miner/protocol_bls.go:542 DKG computeRBO {"round": 179698} 2025-11-10T00:49:27.817Z INFO miner/protocol_bls.go:524 receive bls sign {"round": 179698, "group_signature": "1 c2ddd95b2f1aa384bfec2717baf6882f3f80642ea4b65b8d3702d14ae58931d fce944bd2188d21072d6034f6d5434cea0b331405d5898bd5e9f5ea454b9399", "rboOutput": "249e951d98e5a79791802e6ddb69c68d8aa315a0dacdbfd1d5dc5f724ad85c2c", "dkg_starting_round": 0, "dkg_mb_number": 1} 2025-11-10T00:49:27.817Z DEBUG chain/lfb_round_node.go:33 [mvc] store lfb {"round": 179694, "block": "871c64a36a39760e08b1e5a33c7daff8c82e789f28f5943382521c786e2239c6", "mb number": 1} 2025-11-10T00:49:27.817Z DEBUG chain/worker.go:443 BC is moving {"current_lfb_round": 179694, "last_round": 179693} 2025-11-10T00:49:27.817Z INFO transaction/worker.go:164 cleaning transactions {"collection": "collection.txn:0afc093ffb509f059c55478bc1a60351cef7b4e9c008a53a6cc8241ca8617dfe", "missing_count": 2, "txns": ["6c1901c1d51be9772cc0341863f96cfff1d79bed3ed34f07a8fb96dd92f2d397", "ddb5764c7ce993421d8ab9cc7714de3114cac936b8004bb77045e8251ed969b4"], "past txns": []} 2025-11-10T00:49:27.817Z INFO memorystore/collection.go:65 Redis returned 0 rows after seclect 2025-11-10T00:49:27.817Z DEBUG chain/entity.go:2269 set lfb {"round": 179694, "block": "871c64a36a39760e08b1e5a33c7daff8c82e789f28f5943382521c786e2239c6", "state_computed": true} 2025-11-10T00:49:27.817Z DEBUG chain/state.go:128 finalize round - rebased current state db {"round": 179694, "block": "871c64a36a39760e08b1e5a33c7daff8c82e789f28f5943382521c786e2239c6", "state hash": "a46f078959be7aec8e2582ca3a5b2ba3afc0f676786c5ffd8be4b02deebe2bd8"} 2025-11-10T00:49:27.817Z DEBUG util/mpt_nodedb.go:556 LevelNodeDB rebase db 2025-11-10T00:49:27.817Z DEBUG transaction/worker.go:124 cleaning past transactions 2025-11-10T00:49:27.817Z DEBUG bls/dkg.go:396 dkg verify {"id": "196b96df7631e00d339f9a25131927c4", "key": "1 1f8c72cc3a6b74f6ad7528172b64afe3dc42ee1987495659fe2cf34e749caa7c 20957b4d25e7b5fb1e32d4e3b93e2b73dad7f118efb6dae28715e4ad627b0fff 14259a6ddf4b44c83c1389bd8ed1fc47c1b099c5986bb33923bbcbb25d30054a 2100bb7434dadde1a5ed8545748d0958955bcd21e06cf170f78dbda35a9e04b7", "msg": "179698014abb95ddad6e60", "sig": "1 1c1d9f724f3dc3d029455a9032726470ab868a7c159097c3ed395b6463556c20 d18753ddd5beaaa745966f89127607809bbbc6a6915bccd647d686be73f4af5"} 2025-11-10T00:49:27.817Z DEBUG miner/round.go:238 Round clear - cancel verification 2025-11-10T00:49:27.817Z DEBUG miner/protocol_bls.go:496 VRF Hurray we've threshold BLS shares {"round": 179698, "round pointer": "0xc00c2b1170"} 2025-11-10T00:49:27.817Z DEBUG chain/protocol_block.go:424 finalize block - record dead nodes {"round": 179694, "block": "871c64a36a39760e08b1e5a33c7daff8c82e789f28f5943382521c786e2239c6", "num dead nodes": 15} 2025-11-10T00:49:27.817Z DEBUG round/entity.go:684 add_vrf_share {"round": 179698, "round_vrf_num": 2, "threshold": 2} 2025-11-10T00:49:27.817Z INFO miner/protocol_bls.go:430 verified vrf {"round": 179698, "node_id": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "share": "1 1d4ef0bea35be49e4f76ae89965396571760577f13b0432b547f78323d42171d 13e74e8131136382089ae15a39a6ec34edee01b18fb56e017586c71938c7f29d", "from": "1c3227e496fdf3c9aa604f3470a2bbd1", "message": "179698014abb95ddad6e60"} 2025-11-10T00:49:27.817Z DEBUG miner/chain.go:313 delete txns {"txns": ["6c1901c1d51be9772cc0341863f96cfff1d79bed3ed34f07a8fb96dd92f2d397", "ddb5764c7ce993421d8ab9cc7714de3114cac936b8004bb77045e8251ed969b4"]} 2025-11-10T00:49:27.817Z INFO miner/protocol_block.go:619 update finalized block (debug transaction) {"txn": "ddb5764c7ce993421d8ab9cc7714de3114cac936b8004bb77045e8251ed969b4", "block": "871c64a36a39760e08b1e5a33c7daff8c82e789f28f5943382521c786e2239c6"} 2025-11-10T00:49:27.817Z INFO miner/protocol_block.go:619 update finalized block (debug transaction) {"txn": "6c1901c1d51be9772cc0341863f96cfff1d79bed3ed34f07a8fb96dd92f2d397", "block": "871c64a36a39760e08b1e5a33c7daff8c82e789f28f5943382521c786e2239c6"} 2025-11-10T00:49:27.817Z INFO miner/protocol_block.go:613 update finalized block {"round": 179694, "block": "871c64a36a39760e08b1e5a33c7daff8c82e789f28f5943382521c786e2239c6", "lf_round": 179693, "current_round": 179698, "weight": 1} 2025-11-10T00:49:27.817Z DEBUG chain/protocol_block.go:409 MPT state node stat - inc {"node num": -342556, "change num": 11, "delete num": 15} 2025-11-10T00:49:27.816Z INFO block/entity.go:1195 save state {"round": 179694, "block": "871c64a36a39760e08b1e5a33c7daff8c82e789f28f5943382521c786e2239c6", "block_size": 2, "changes": 11, "client_state": "a46f078959be7aec8e2582ca3a5b2ba3afc0f676786c5ffd8be4b02deebe2bd8", "duration": "2.00136ms"} 2025-11-10T00:49:27.816Z DEBUG bls/dkg.go:396 dkg verify {"id": "1c3227e496fdf3c9aa604f3470a2bbd1", "key": "1 6603e20478fac2c72a61b85056977b92696b8fffd408d8acac0e1f47aed3f96 1501242ed9000d9c6a02764160261164a52360a692c34ed452ff097bc90ee9b3 7f8aaa178d31fa4cbd0c1974768dfa4921e29405754ebf8d2c163a774b741a2 24515e04bd685a5559260f5d1868e5ea11abaf21f55a56aee52c15d9f3c2b053", "msg": "179698014abb95ddad6e60", "sig": "1 1d4ef0bea35be49e4f76ae89965396571760577f13b0432b547f78323d42171d 13e74e8131136382089ae15a39a6ec34edee01b18fb56e017586c71938c7f29d"} 2025-11-10T00:49:27.816Z DEBUG round/entity.go:684 add_vrf_share {"round": 179698, "round_vrf_num": 1, "threshold": 2} 2025-11-10T00:49:27.816Z INFO miner/protocol_bls.go:430 verified vrf {"round": 179698, "node_id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "share": "1 22f01e9027c79d29a1fa29b5aafff069e2d8c4eb8388fdf7dbebc2a2a0e7d0bb 17ae84f92d609ccdd1b84c96f0dfd889af7773500f0da740415f2398fc4ed799", "from": "18f9a15b9551f8552a19cf4750ef14bf", "message": "179698014abb95ddad6e60"} 2025-11-10T00:49:27.816Z INFO miner/protocol_bls.go:265 BLS sign VRF share calculated for {"round": 179698, "round_timeout": 0, "prev_rseed": 93092994658168416, "prev round vrf random seed": "14abb95ddad6e60", "bls_msg": "179698014abb95ddad6e60"} 2025-11-10T00:49:27.816Z DEBUG util/merkle_patricia_trie.go:272 MPT save changes success {"duration": "1.41354ms"} 2025-11-10T00:49:27.816Z INFO miner/protocol_bls.go:364 DKG AddVRFShare {"round": 179698, "round_vrf_num": 0, "threshold": 2, "sender": 0, "round_timeout_count": 0, "vrf_timeout_count": 0, "vrf_share": "1 1c1d9f724f3dc3d029455a9032726470ab868a7c159097c3ed395b6463556c20 d18753ddd5beaaa745966f89127607809bbbc6a6915bccd647d686be73f4af5"} 2025-11-10T00:49:27.816Z DEBUG miner/protocol_receive.go:26 handle vrf share {"round": 179698, "vrf_timeout_count": 0, "sender_index": 0} 2025-11-10T00:49:27.816Z DEBUG util/mpt_node_change.go:156 MPT - update changes done {"changes": 11} 2025-11-10T00:49:27.816Z DEBUG miner/worker.go:53 message {"msg": {"code":"vrf_share","value":"VRF Share"}, "sender_index": 0, "id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341"} 2025-11-10T00:49:27.815Z DEBUG bls/dkg.go:396 dkg verify {"id": "18f9a15b9551f8552a19cf4750ef14bf", "key": "1 15981a99909f8d701bca846be62c295e8958436831d3087ded78a1719a92f9a9 1bc96c0fea12a9ee4451600417977d1e987b252b469ea7c7be9d40e681fceff4 164089f6538d2b42ac3b37af7bc35e2550212af1e8ccedfeec4bde4f472dd384 aa502eaa78fb0cc02bd92538e258b55b1495cdc393205378d4ead83eb106f33", "msg": "179698014abb95ddad6e60", "sig": "1 22f01e9027c79d29a1fa29b5aafff069e2d8c4eb8388fdf7dbebc2a2a0e7d0bb 17ae84f92d609ccdd1b84c96f0dfd889af7773500f0da740415f2398fc4ed799"} 2025-11-10T00:49:27.815Z DEBUG util/mpt_node_change.go:150 MPT - update changes {"changes": 11} 2025-11-10T00:49:27.815Z INFO miner/protocol_bls.go:265 BLS sign VRF share calculated for {"round": 179698, "round_timeout": 0, "prev_rseed": 93092994658168416, "prev round vrf random seed": "14abb95ddad6e60", "bls_msg": "179698014abb95ddad6e60"} 2025-11-10T00:49:27.815Z INFO miner/protocol_bls.go:364 DKG AddVRFShare {"round": 179698, "round_vrf_num": 0, "threshold": 2, "sender": 2, "round_timeout_count": 0, "vrf_timeout_count": 0, "vrf_share": "1 1d4ef0bea35be49e4f76ae89965396571760577f13b0432b547f78323d42171d 13e74e8131136382089ae15a39a6ec34edee01b18fb56e017586c71938c7f29d"} 2025-11-10T00:49:27.815Z INFO miner/protocol_round.go:78 add_my_vrf_share {"round": 179698, "round_timeout": 0, "dkg_starting_round": 0, "dkg_mb_number": 1, "pr_seed": 93092994658168416, "pr_vrf_seed": "14abb95ddad6e60", "share": "1 1d4ef0bea35be49e4f76ae89965396571760577f13b0432b547f78323d42171d 13e74e8131136382089ae15a39a6ec34edee01b18fb56e017586c71938c7f29d"} 2025-11-10T00:49:27.815Z INFO miner/protocol_bls.go:265 BLS sign VRF share calculated for {"round": 179698, "round_timeout": 0, "prev_rseed": 93092994658168416, "prev round vrf random seed": "14abb95ddad6e60", "bls_msg": "179698014abb95ddad6e60"} 2025-11-10T00:49:27.815Z DEBUG miner/protocol_bls.go:305 get_bls_share {"round": 179698, "rtc": 0, "dkg_pi": "1 6603e20478fac2c72a61b85056977b92696b8fffd408d8acac0e1f47aed3f96 1501242ed9000d9c6a02764160261164a52360a692c34ed452ff097bc90ee9b3 7f8aaa178d31fa4cbd0c1974768dfa4921e29405754ebf8d2c163a774b741a2 24515e04bd685a5559260f5d1868e5ea11abaf21f55a56aee52c15d9f3c2b053", "dkg_sr": 0, "mb_sr": 0, "share": "1 1d4ef0bea35be49e4f76ae89965396571760577f13b0432b547f78323d42171d 13e74e8131136382089ae15a39a6ec34edee01b18fb56e017586c71938c7f29d"} 2025-11-10T00:49:27.814Z INFO miner/protocol_bls.go:364 DKG AddVRFShare {"round": 179698, "round_vrf_num": 0, "threshold": 2, "sender": 2, "round_timeout_count": 0, "vrf_timeout_count": 0, "vrf_share": "1 1d4ef0bea35be49e4f76ae89965396571760577f13b0432b547f78323d42171d 13e74e8131136382089ae15a39a6ec34edee01b18fb56e017586c71938c7f29d"} 2025-11-10T00:49:27.814Z INFO miner/protocol_round.go:78 add_my_vrf_share {"round": 179698, "round_timeout": 0, "dkg_starting_round": 0, "dkg_mb_number": 1, "pr_seed": 93092994658168416, "pr_vrf_seed": "14abb95ddad6e60", "share": "1 1d4ef0bea35be49e4f76ae89965396571760577f13b0432b547f78323d42171d 13e74e8131136382089ae15a39a6ec34edee01b18fb56e017586c71938c7f29d"} 2025-11-10T00:49:27.814Z DEBUG miner/protocol_bls.go:305 get_bls_share {"round": 179698, "rtc": 0, "dkg_pi": "1 6603e20478fac2c72a61b85056977b92696b8fffd408d8acac0e1f47aed3f96 1501242ed9000d9c6a02764160261164a52360a692c34ed452ff097bc90ee9b3 7f8aaa178d31fa4cbd0c1974768dfa4921e29405754ebf8d2c163a774b741a2 24515e04bd685a5559260f5d1868e5ea11abaf21f55a56aee52c15d9f3c2b053", "dkg_sr": 0, "mb_sr": 0, "share": "1 1d4ef0bea35be49e4f76ae89965396571760577f13b0432b547f78323d42171d 13e74e8131136382089ae15a39a6ec34edee01b18fb56e017586c71938c7f29d"} 2025-11-10T00:49:27.814Z DEBUG bls/dkg.go:356 dkg sign {"key": "21d97039e984194d599f2bf60c03d185c67ff756eba44a56ac9cf108c33c814a", "pi": "1 6603e20478fac2c72a61b85056977b92696b8fffd408d8acac0e1f47aed3f96 1501242ed9000d9c6a02764160261164a52360a692c34ed452ff097bc90ee9b3 7f8aaa178d31fa4cbd0c1974768dfa4921e29405754ebf8d2c163a774b741a2 24515e04bd685a5559260f5d1868e5ea11abaf21f55a56aee52c15d9f3c2b053"} 2025-11-10T00:49:27.814Z DEBUG chain/protocol_round.go:160 finalize round {"round": 179697, "lf_round": 179693} 2025-11-10T00:49:27.814Z DEBUG miner/protocol_bls.go:293 Sign msg with dkg {"msg": "179698014abb95ddad6e60", "round": 179698, "dkg starting round": 0} 2025-11-10T00:49:27.814Z INFO round/entity.go:618 get miners by rank {"num_miners": 3, "round": 179694, "r.minerPerm": [1, 2, 0]} 2025-11-10T00:49:27.814Z INFO chain/protocol_block.go:363 finalize block -- round {"round": {"number":179694,"round_random_seed":-4604624124942038346,"block_hash":"871c64a36a39760e08b1e5a33c7daff8c82e789f28f5943382521c786e2239c6","vrf_output":"c01916c134a2cab632cefade8ef586e9da6ece93a18e9cd3f88e51ed1da1e245"}, "block": "871c64a36a39760e08b1e5a33c7daff8c82e789f28f5943382521c786e2239c6"} 2025-11-10T00:49:27.814Z INFO chain/protocol_block.go:328 finalize block {"round": 179694, "current_round": 179698, "lf_round": 179693, "hash": "871c64a36a39760e08b1e5a33c7daff8c82e789f28f5943382521c786e2239c6", "round_rank": 0, "state": 7} 2025-11-10T00:49:27.814Z DEBUG chain/worker.go:262 start to finalize block {"round": 179694, "block": "871c64a36a39760e08b1e5a33c7daff8c82e789f28f5943382521c786e2239c6", "prev block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681"} 2025-11-10T00:49:27.814Z INFO miner/protocol_bls.go:265 BLS sign VRF share calculated for {"round": 179698, "round_timeout": 0, "prev_rseed": 93092994658168416, "prev round vrf random seed": "14abb95ddad6e60", "bls_msg": "179698014abb95ddad6e60"} 2025-11-10T00:49:27.814Z INFO miner/protocol_bls.go:283 DKG getBlsShare {"Round Number": 179698} 2025-11-10T00:49:27.814Z INFO miner/protocol_round.go:244 StartNextRound - add VRF {"round": 179698} 2025-11-10T00:49:27.814Z DEBUG bls/dkg.go:356 dkg sign {"key": "21d97039e984194d599f2bf60c03d185c67ff756eba44a56ac9cf108c33c814a", "pi": "1 6603e20478fac2c72a61b85056977b92696b8fffd408d8acac0e1f47aed3f96 1501242ed9000d9c6a02764160261164a52360a692c34ed452ff097bc90ee9b3 7f8aaa178d31fa4cbd0c1974768dfa4921e29405754ebf8d2c163a774b741a2 24515e04bd685a5559260f5d1868e5ea11abaf21f55a56aee52c15d9f3c2b053"} 2025-11-10T00:49:27.814Z INFO chain/protocol_round.go:359 finalize round {"round": 179694, "lfb round": 179696, "block": "871c64a36a39760e08b1e5a33c7daff8c82e789f28f5943382521c786e2239c6"} 2025-11-10T00:49:27.814Z DEBUG chain/protocol_round.go:156 finalize_round: already finalizing {"round": 179697} 2025-11-10T00:49:27.814Z DEBUG miner/protocol_bls.go:293 Sign msg with dkg {"msg": "179698014abb95ddad6e60", "round": 179698, "dkg starting round": 0} 2025-11-10T00:49:27.814Z INFO miner/round.go:40 Try to cancel block generation that have not been started yet {"round": 179697} 2025-11-10T00:49:27.814Z DEBUG miner/protocol_round.go:210 finalizedRound - cancel round verification {"round": 179697} 2025-11-10T00:49:27.814Z INFO miner/protocol_bls.go:265 BLS sign VRF share calculated for {"round": 179698, "round_timeout": 0, "prev_rseed": 93092994658168416, "prev round vrf random seed": "14abb95ddad6e60", "bls_msg": "179698014abb95ddad6e60"} 2025-11-10T00:49:27.814Z DEBUG miner/protocol_round.go:154 [wait not ahead] [2] not ahead, can move on {"round": 179697, "lfb tk round": 179693} 2025-11-10T00:49:27.814Z INFO chain/protocol_round.go:326 finalize round - latest finalized round {"round": 179697, "lfb round": 179696, "lfb block": "14482f721677a955910a55bd0cdd44f655d2497180061be5d9cd6ae0f187c922"} 2025-11-10T00:49:27.814Z INFO miner/protocol_bls.go:283 DKG getBlsShare {"Round Number": 179698} 2025-11-10T00:49:27.814Z INFO chain/protocol_round.go:199 finalize round {"round": 179697, "plfb_round": 179693, "num_round_notarized": 1, "num_chain_notarized": 3} 2025-11-10T00:49:27.814Z DEBUG miner/protocol_round.go:123 [wait not ahead] 2025-11-10T00:49:27.814Z INFO miner/protocol_receive.go:370 process notarization success {"round": 179697, "block": "7086923e0045bf4137778c39dd21dc307cda9a8f9c6581a7eab1608203fb852d", "duration": "2.473486ms"} 2025-11-10T00:49:27.814Z DEBUG chain/protocol_round.go:160 finalize round {"round": 179697, "lf_round": 179693} 2025-11-10T00:49:27.814Z INFO miner/round.go:40 Try to cancel block generation that have not been started yet {"round": 179697} 2025-11-10T00:49:27.814Z INFO miner/protocol_round.go:244 StartNextRound - add VRF {"round": 179698} 2025-11-10T00:49:27.813Z INFO miner/round.go:40 Try to cancel block generation that have not been started yet {"round": 179697} 2025-11-10T00:49:27.813Z DEBUG miner/protocol_round.go:210 finalizedRound - cancel round verification {"round": 179697} 2025-11-10T00:49:27.813Z INFO chain/entity.go:2016 Moving to the next round {"next_round": 179698} 2025-11-10T00:49:27.813Z INFO miner/protocol_receive.go:456 process notarization - start next round {"new round": 179698} 2025-11-10T00:49:27.813Z DEBUG miner/protocol_round.go:154 [wait not ahead] [2] not ahead, can move on {"round": 179697, "lfb tk round": 179693} 2025-11-10T00:49:27.813Z DEBUG round/entity.go:311 add notarized block - block already exist, merge tickets {"round": 179697, "block": "7086923e0045bf4137778c39dd21dc307cda9a8f9c6581a7eab1608203fb852d"} 2025-11-10T00:49:27.813Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 179697, "randk": 0, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T00:49:27.813Z DEBUG miner/protocol_round.go:991 verification_complete {"top_verified_rank": 0} 2025-11-10T00:49:27.813Z INFO miner/protocol_round.go:986 verification_complete {"round": 179697, "verified_blocks": 0} 2025-11-10T00:49:27.813Z DEBUG miner/protocol_round.go:123 [wait not ahead] 2025-11-10T00:49:27.813Z INFO chain/entity.go:1571 Adding a notarized block for current round {"Round": 179697} 2025-11-10T00:49:27.813Z INFO miner/round.go:44 Cancelling block generation {"round": 179697} 2025-11-10T00:49:27.813Z INFO miner/round.go:230 Cancelling verification {"round": 179697} 2025-11-10T00:49:27.813Z INFO miner/protocol_receive.go:456 process notarization - start next round {"new round": 179698} 2025-11-10T00:49:27.813Z DEBUG miner/protocol_round.go:1149 check block notarization - block notarized {"round": 179697, "block": "7086923e0045bf4137778c39dd21dc307cda9a8f9c6581a7eab1608203fb852d"} 2025-11-10T00:49:27.813Z DEBUG round/entity.go:344 reached notarization {"round": 179697} 2025-11-10T00:49:27.813Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 179697, "randk": 0, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T00:49:27.813Z INFO chain/entity.go:1571 Adding a notarized block for current round {"Round": 179697} 2025-11-10T00:49:27.813Z INFO chain/protocol_block.go:319 reached notarization - merging tickets {"round": 179697, "current_round": 179697, "block": "7086923e0045bf4137778c39dd21dc307cda9a8f9c6581a7eab1608203fb852d", "tickets_num": 2} 2025-11-10T00:49:27.812Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"notarization","value":"Notarization"}, "sender_index": 0, "id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "duration": "95.592µs"} 2025-11-10T00:49:27.811Z DEBUG miner/worker.go:53 message {"msg": {"code":"notarization","value":"Notarization"}, "sender_index": 0, "id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341"} 2025-11-10T00:49:27.812Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"vrf_share","value":"VRF Share"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "duration": "103.142µs"} 2025-11-10T00:49:27.812Z DEBUG miner/protocol_receive.go:33 received VRF share for the future round, caching it {"current_round": 179697, "vrf_share_round": 179698} 2025-11-10T00:49:27.811Z DEBUG miner/protocol_receive.go:26 handle vrf share {"round": 179698, "vrf_timeout_count": 0, "sender_index": 0} 2025-11-10T00:49:27.811Z DEBUG miner/worker.go:53 message {"msg": {"code":"vrf_share","value":"VRF Share"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71"} 2025-11-10T00:49:27.811Z DEBUG miner/protocol_receive.go:428 process notarization - merge notarization block {"round": 179697, "block": "7086923e0045bf4137778c39dd21dc307cda9a8f9c6581a7eab1608203fb852d"} 2025-11-10T00:49:27.811Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"notarization","value":"Notarization"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "duration": "81.251µs"} 2025-11-10T00:49:27.811Z DEBUG miner/worker.go:53 message {"msg": {"code":"notarization","value":"Notarization"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71"} 2025-11-10T00:49:27.800Z DEBUG miner/protocol_round.go:943 verifyAndSend - finished successfully {"round": 179697, "block": "7086923e0045bf4137778c39dd21dc307cda9a8f9c6581a7eab1608203fb852d"} 2025-11-10T00:49:27.800Z INFO miner/protocol_round.go:1127 checkBlockNotarization -- block is not Notarized. Returning {"round": 179697, "block hash": "7086923e0045bf4137778c39dd21dc307cda9a8f9c6581a7eab1608203fb852d"} 2025-11-10T00:49:27.800Z INFO chain/protocol_block.go:225 not reached notarization {"mb_sr": 0, "active_miners": 3, "threshold": 2, "num_signatures": 1, "current_round": 179697, "round": 179697} 2025-11-10T00:49:27.800Z INFO miner/protocol_round.go:920 verifyAndSend - sending verification ticket {"round": 179697, "block": "7086923e0045bf4137778c39dd21dc307cda9a8f9c6581a7eab1608203fb852d", "block_rank": 0, "RRS": 93092994658168416} 2025-11-10T00:49:27.799Z DEBUG miner/protocol_round.go:1040 verify round block {"round": 179697, "block": "7086923e0045bf4137778c39dd21dc307cda9a8f9c6581a7eab1608203fb852d"} 2025-11-10T00:49:27.799Z DEBUG miner/protocol_round.go:865 verifyAndSend - started {"block": "7086923e0045bf4137778c39dd21dc307cda9a8f9c6581a7eab1608203fb852d"} 2025-11-10T00:49:27.799Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 179697, "randk": 1, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T00:49:27.799Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 179697, "randk": 0, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T00:49:27.799Z INFO miner/protocol_round.go:951 Started main verification loop {"round": 179697} 2025-11-10T00:49:27.791Z DEBUG chain/entity.go:440 process block, no block in buffer {"current round": 179697} 2025-11-10T00:49:27.781Z DEBUG chain/protocol_lfb_ticket.go:386 update lfb ticket - ticket.Round <= latest.Round {"ticket.Round": 179693, "latest.Round": 179693} 2025-11-10T00:49:27.776Z DEBUG chain/protocol_lfb_ticket.go:386 update lfb ticket - ticket.Round <= latest.Round {"ticket.Round": 179693, "latest.Round": 179693} 2025-11-10T00:49:27.690Z DEBUG chain/entity.go:440 process block, no block in buffer {"current round": 179697} 2025-11-10T00:49:27.633Z DEBUG miner/protocol_round.go:1028 verify block - pending {"round": 179697, "block": "7086923e0045bf4137778c39dd21dc307cda9a8f9c6581a7eab1608203fb852d"} 2025-11-10T00:49:27.633Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 179697, "randk": 0, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T00:49:27.633Z DEBUG miner/round.go:143 Adding block to verifyChannel {"round": 179697, "block hash": "7086923e0045bf4137778c39dd21dc307cda9a8f9c6581a7eab1608203fb852d", "magic block": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "magic block round": 0} 2025-11-10T00:49:27.633Z INFO miner/protocol_round.go:803 adding block to verify {"round": 179697, "block": "7086923e0045bf4137778c39dd21dc307cda9a8f9c6581a7eab1608203fb852d", "prev_block": "14482f721677a955910a55bd0cdd44f655d2497180061be5d9cd6ae0f187c922", "state_hash": "851e21808cf53bab5e8cb5ee594529f3022dddd114d001b36ab87f14ba611c84", "weight": 1} 2025-11-10T00:49:27.633Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 179697, "randk": 0, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T00:49:27.633Z DEBUG statecache/statecache.go:131 statecache - commit {"block": "7086923e0045bf4137778c39dd21dc307cda9a8f9c6581a7eab1608203fb852d", "bc_hits": 58, "bc_miss": 0, "sc_hits": 16632520, "sc_miss": 4957, "duration": "439.726µs"} 2025-11-10T00:49:27.633Z INFO miner/protocol_block.go:1316 generate block (assemble+update+sign) {"round": 179697, "block_size": 1, "reused_txns": 0, "reused_txns": 0, "time": "13.858083ms", "block": "7086923e0045bf4137778c39dd21dc307cda9a8f9c6581a7eab1608203fb852d", "prev_block": "14482f721677a955910a55bd0cdd44f655d2497180061be5d9cd6ae0f187c922", "begin_state_hash": "5b1f334944f259548b7486067e4f2e2be904300697b5b65adee835dd5d3c3298", "block_state_hash": "851e21808cf53bab5e8cb5ee594529f3022dddd114d001b36ab87f14ba611c84", "computed_state_hash": "851e21808cf53bab5e8cb5ee594529f3022dddd114d001b36ab87f14ba611c84", "changes": 12, "state_status": 4, "iteration_count": 0} 2025-11-10T00:49:27.633Z DEBUG miner/protocol_block.go:1305 generate block (assemble+update) {"round": 179697, "txns": 1, "time": "13.579639ms"} 2025-11-10T00:49:27.632Z DEBUG miner/protocol_block.go:1282 generate block (assemble) {"round": 179697, "txns": 1, "time": "13.520698ms"} 2025-11-10T00:49:27.631Z DEBUG chain/state.go:961 Updating nonce {"client": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "new_nonce": 92493} 2025-11-10T00:49:27.630Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T00:49:27.630Z INFO chain/state.go:533 SC executed {"client id": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "block": "", "round": 179697, "prev_state_hash": "5b1f334944f259548b7486067e4f2e2be904300697b5b65adee835dd5d3c3298", "txn_hash": "906327ee18121616283165ee090cb0df33ce3331d098dfe05ec3a734c4866f83", "txn_nonce": 92493, "txn_func": "payFees", "txn_status": 0, "txn_exec_time": "9.114103ms", "begin client state": "5b1f334944f259548b7486067e4f2e2be904300697b5b65adee835dd5d3c3298", "current_root": "57056db540d5a692effe0e27a519f4202b270d4e77c51375964d9e6cb8bbd8d5", "mpt_cache_hit": 45, "mpt_cache_miss": 0, "output": ""} 2025-11-10T00:49:27.630Z DEBUG miner/protocol_round.go:1028 verify block - pending {"round": 179697, "block": "3a50b4ee2ade2599bcdd734a73e537b4967a034ea3ae6d36c7748dd314dd97ff"} 2025-11-10T00:49:27.630Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 179697, "randk": 1, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T00:49:27.630Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T00:49:27.630Z DEBUG miner/protocol_receive.go:130 verify block processed {"round": 179697, "block": "3a50b4ee2ade2599bcdd734a73e537b4967a034ea3ae6d36c7748dd314dd97ff"} 2025-11-10T00:49:27.630Z DEBUG miner/round.go:143 Adding block to verifyChannel {"round": 179697, "block hash": "3a50b4ee2ade2599bcdd734a73e537b4967a034ea3ae6d36c7748dd314dd97ff", "magic block": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "magic block round": 0} 2025-11-10T00:49:27.630Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T00:49:27.629Z DEBUG miner/protocol_round.go:759 update prev block notarization, already notarized {"round": 179696, "block": "14482f721677a955910a55bd0cdd44f655d2497180061be5d9cd6ae0f187c922"} 2025-11-10T00:49:27.629Z INFO miner/protocol_round.go:803 adding block to verify {"round": 179697, "block": "3a50b4ee2ade2599bcdd734a73e537b4967a034ea3ae6d36c7748dd314dd97ff", "prev_block": "14482f721677a955910a55bd0cdd44f655d2497180061be5d9cd6ae0f187c922", "state_hash": "b618fbfd341f0e121aa3e895d98c2b51652237f55c1f471516f48ab07b9c4bbb", "weight": 1} 2025-11-10T00:49:27.629Z INFO miner/protocol_round.go:613 handle verify block - added block for ticket verification {"round": 179697, "block": "3a50b4ee2ade2599bcdd734a73e537b4967a034ea3ae6d36c7748dd314dd97ff", "magic block": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "magic block round": 0} 2025-11-10T00:49:27.629Z INFO chain/protocol_block.go:225 not reached notarization {"mb_sr": 0, "active_miners": 3, "threshold": 2, "num_signatures": 0, "current_round": 179697, "round": 179697} 2025-11-10T00:49:27.629Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T00:49:27.629Z DEBUG miner/protocol_receive.go:169 verify block {"round": 179697, "block": "3a50b4ee2ade2599bcdd734a73e537b4967a034ea3ae6d36c7748dd314dd97ff"} 2025-11-10T00:49:27.628Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"verify_block","value":"Verify Block"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "duration": "78.031µs"} 2025-11-10T00:49:27.628Z DEBUG miner/worker.go:53 message {"msg": {"code":"verify_block","value":"Verify Block"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71"} 2025-11-10T00:49:27.628Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T00:49:27.622Z ERROR minersc/global_node.go:372 failed to get current magic block {"error": "value not present"} 0chain.net/smartcontract/minersc.(*GlobalNode).prevMagicBlock /0chain/code/go/0chain.net/smartcontract/minersc/global_node.go:372 0chain.net/smartcontract/minersc.getRegisterShardersInMagicBlock /0chain/code/go/0chain.net/smartcontract/minersc/fees.go:659 0chain.net/smartcontract/minersc.(*MinerSmartContract).payFees /0chain/code/go/0chain.net/smartcontract/minersc/fees.go:519 0chain.net/smartcontract/minersc.(*MinerSmartContract).Execute /0chain/code/go/0chain.net/smartcontract/minersc/sc.go:139 0chain.net/chaincore/smartcontract.ExecuteWithStats /0chain/code/go/0chain.net/chaincore/smartcontract/handler.go:52 0chain.net/chaincore/smartcontract.ExecuteSmartContract /0chain/code/go/0chain.net/chaincore/smartcontract/handler.go:67 0chain.net/chaincore/chain.(*Chain).ExecuteSmartContract.func1 /0chain/code/go/0chain.net/chaincore/chain/state.go:158 2025-11-10T00:49:27.622Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "6dba10422e368813802877a85039d3985d96760ed844092319743fb3a76712d9d2208fe938b7465b9c5dc571053986cf8dbf3585fb36399f98ea569c42f50b76"} 2025-11-10T00:49:27.622Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "6dba10422e368813802877a85039d3985d96760ed844092319743fb3a76712d9b5e8a1650666fdd3a9de7855b6da63ab629b1701f23738477e2325f7ca2150ac"} 2025-11-10T00:49:27.622Z DEBUG minersc/fees.go:480 pay_fees, got miner id successfully {"miner id": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "round": 179697, "block": ""} 2025-11-10T00:49:27.621Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T00:49:27.621Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T00:49:27.621Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T00:49:27.621Z DEBUG chain/protocol_view_change.go:424 [mvc] nonce, set nonce in getCurrentSelfNonce {"nonce": 92492} 2025-11-10T00:49:27.621Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "%\ufffd\u0012\ufffd\ufffd\ufffd\ufffd\ufffd\ufffd\ufffd\u000f\ufffd\ufffd;I\\\ufffd\u0013\ufffdQr/b\ufffd\r\ufffd\ufffd+N!\ufffd\u0016"} 2025-11-10T00:49:27.621Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\u0014\u001do\u001b6-]x!3\ufffdfvv\ufffd\ufffdu\ufffda\ufffd8PXt\ufffd\rn\u0012ȥ\ufffd\ufffd"} 2025-11-10T00:49:27.621Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\ufffd_[\ufffd\ufffd\ufffd\ufffd=\ufffd\ufffd\ufffdZ\ufffd\ufffda\ufffd\ufffd\ufffd\ufffd\ufffd\u0016Wxa\ufffd\ufffd\ufffdu0\ufffd#*"} 2025-11-10T00:49:27.620Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\ufffd\ufffdv\ufffd\ufffdl\ufffdr\ufffd\ufffd\ufffdF\ufffd+\ufffd\u0017H{~\ufffd\ufffd\ufffdi\ufffdO\ufffd\u0000\ufffd\ufffd\ufffd\ufffd\ufffd"} 2025-11-10T00:49:27.620Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "<\ufffd>\ufffds\ufffd)z\ufffd\ufffd%|F\ufffd\u001a\ufffd3k\u00119\u0013\ufffdf\ufffd\ufffd\ufffd\ufffdݬ)\u0010u"} 2025-11-10T00:49:27.620Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "[\u001f3ID\ufffdYT\ufffdt\ufffd\u0006~O.+\ufffd\u00040\u0006\ufffd\ufffd\ufffdZ\ufffd\ufffd5\ufffd]<2\ufffd"} 2025-11-10T00:49:27.620Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T00:49:27.620Z DEBUG chain/protocol_view_change.go:431 [mvc] nonce, get current miner nonce {"minerId": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea"} 2025-11-10T00:49:27.620Z INFO memorystore/collection.go:65 Redis returned 0 rows after seclect 2025-11-10T00:49:27.620Z INFO miner/protocol_block.go:1112 generate block starting iteration {"round": 179697, "prev_block": "14482f721677a955910a55bd0cdd44f655d2497180061be5d9cd6ae0f187c922", "prev_state_hash": "5b1f334944f259548b7486067e4f2e2be904300697b5b65adee835dd5d3c3298"} 2025-11-10T00:49:27.619Z DEBUG statecache/statecache.go:173 state cache - see gap {"block": "0a1d0709e7b36484236f49ba15512201289834420ea9115ff09c91df3763330c"} 2025-11-10T00:49:27.619Z DEBUG statecache/statecache.go:173 state cache - see gap {"block": "0a1d0709e7b36484236f49ba15512201289834420ea9115ff09c91df3763330c"} 2025-11-10T00:49:27.619Z DEBUG statecache/statecache.go:173 state cache - see gap {"block": "0a1d0709e7b36484236f49ba15512201289834420ea9115ff09c91df3763330c"} 2025-11-10T00:49:27.619Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"vrf_share","value":"VRF Share"}, "sender_index": 0, "id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "duration": "1.290909ms"} 2025-11-10T00:49:27.619Z INFO miner/protocol_bls.go:481 DKG ThresholdNumSigReceived VRF is already completed. {"round": 179697} 2025-11-10T00:49:27.619Z INFO round/entity.go:675 add_vrf_share already at threshold. Returning false. 2025-11-10T00:49:27.619Z INFO miner/protocol_bls.go:430 verified vrf {"round": 179697, "node_id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "share": "1 d6487bfeca09b5c3b1ac8dc086a7b429856e79f7098fae24f6e7a0ce8ee39a0 25146814eae1bacacb00e731afcf1517e4891f8394ba59c64dbd9abdef5b98cc", "from": "196b96df7631e00d339f9a25131927c4", "message": "1796970-1680a9576a39e579"} 2025-11-10T00:49:27.619Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 179697, "randk": 0, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T00:49:27.619Z DEBUG miner/protocol_round.go:467 Setting LFMB round/hash for a block {"rn": 179697, "mc.crn": 179697, "rnoff": 179672, "nvc": 0, "r": 0, "h": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "b.lfmbr": 0, "b.lfmbh": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4"} 2025-11-10T00:49:27.619Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"vrf_share","value":"VRF Share"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "duration": "1.689075ms"} 2025-11-10T00:49:27.619Z INFO miner/protocol_round.go:830 Starting round verification {"round": 179697, "delta": "180ms"} 2025-11-10T00:49:27.619Z INFO round/entity.go:618 get miners by rank {"num_miners": 3, "round": 179697, "r.minerPerm": [1, 2, 0]} 2025-11-10T00:49:27.619Z INFO miner/protocol_round.go:340 *** TOC_FIX starting round block generation *** {"round": 179697, "index": 2, "rank": 0, "timeout_count": 0, "random_seed": 93092994658168416, "lf_round": 179693} 2025-11-10T00:49:27.619Z INFO miner/protocol_bls.go:591 Starting round with vrf {"round": 179697, "roundtimeout": 0, "rseed": 93092994658168416, "prev_round": 179696, "Prev_rseed": 0} 2025-11-10T00:49:27.619Z DEBUG miner/protocol_bls.go:542 DKG computeRBO {"round": 179697} 2025-11-10T00:49:27.619Z INFO miner/protocol_bls.go:524 receive bls sign {"round": 179697, "group_signature": "1 e419d8ee15e7aaecaf628b5e5f9c422dd5c51fa6240110af204ef36cfa66e4f 4b83b3f0ecab14eeb1e5bc0bf4a3c3c5e8e437da439c45ca10f76cb518c0f2", "rboOutput": "014abb95ddad6e6027f1f0af08fc537ea4ad9298150601aaa12befd5ce2e114d", "dkg_starting_round": 0, "dkg_mb_number": 1} 2025-11-10T00:49:27.618Z DEBUG bls/dkg.go:396 dkg verify {"id": "196b96df7631e00d339f9a25131927c4", "key": "1 1f8c72cc3a6b74f6ad7528172b64afe3dc42ee1987495659fe2cf34e749caa7c 20957b4d25e7b5fb1e32d4e3b93e2b73dad7f118efb6dae28715e4ad627b0fff 14259a6ddf4b44c83c1389bd8ed1fc47c1b099c5986bb33923bbcbb25d30054a 2100bb7434dadde1a5ed8545748d0958955bcd21e06cf170f78dbda35a9e04b7", "msg": "1796970-1680a9576a39e579", "sig": "1 d6487bfeca09b5c3b1ac8dc086a7b429856e79f7098fae24f6e7a0ce8ee39a0 25146814eae1bacacb00e731afcf1517e4891f8394ba59c64dbd9abdef5b98cc"} 2025-11-10T00:49:27.618Z DEBUG miner/protocol_bls.go:496 VRF Hurray we've threshold BLS shares {"round": 179697, "round pointer": "0xc00ecdab40"} 2025-11-10T00:49:27.618Z DEBUG round/entity.go:684 add_vrf_share {"round": 179697, "round_vrf_num": 2, "threshold": 2} 2025-11-10T00:49:27.618Z INFO miner/protocol_bls.go:430 verified vrf {"round": 179697, "node_id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "share": "1 12c57df24167b442c182ee9c0592afadb4d52ca641db9ff6d7f41dcf2950564e 1de83131a1a8323536474afaafa1e1e460c21db41596d8270dd18449aa99865f", "from": "18f9a15b9551f8552a19cf4750ef14bf", "message": "1796970-1680a9576a39e579"} 2025-11-10T00:49:27.618Z INFO miner/protocol_bls.go:265 BLS sign VRF share calculated for {"round": 179697, "round_timeout": 0, "prev_rseed": -1621482058762806649, "prev round vrf random seed": "-1680a9576a39e579", "bls_msg": "1796970-1680a9576a39e579"} 2025-11-10T00:49:27.618Z INFO miner/protocol_bls.go:364 DKG AddVRFShare {"round": 179697, "round_vrf_num": 1, "threshold": 2, "sender": 0, "round_timeout_count": 0, "vrf_timeout_count": 0, "vrf_share": "1 d6487bfeca09b5c3b1ac8dc086a7b429856e79f7098fae24f6e7a0ce8ee39a0 25146814eae1bacacb00e731afcf1517e4891f8394ba59c64dbd9abdef5b98cc"} 2025-11-10T00:49:27.618Z DEBUG miner/protocol_receive.go:26 handle vrf share {"round": 179697, "vrf_timeout_count": 0, "sender_index": 0} 2025-11-10T00:49:27.618Z DEBUG miner/worker.go:53 message {"msg": {"code":"vrf_share","value":"VRF Share"}, "sender_index": 0, "id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341"} 2025-11-10T00:49:27.617Z DEBUG bls/dkg.go:396 dkg verify {"id": "18f9a15b9551f8552a19cf4750ef14bf", "key": "1 15981a99909f8d701bca846be62c295e8958436831d3087ded78a1719a92f9a9 1bc96c0fea12a9ee4451600417977d1e987b252b469ea7c7be9d40e681fceff4 164089f6538d2b42ac3b37af7bc35e2550212af1e8ccedfeec4bde4f472dd384 aa502eaa78fb0cc02bd92538e258b55b1495cdc393205378d4ead83eb106f33", "msg": "1796970-1680a9576a39e579", "sig": "1 12c57df24167b442c182ee9c0592afadb4d52ca641db9ff6d7f41dcf2950564e 1de83131a1a8323536474afaafa1e1e460c21db41596d8270dd18449aa99865f"} 2025-11-10T00:49:27.617Z INFO miner/protocol_bls.go:265 BLS sign VRF share calculated for {"round": 179697, "round_timeout": 0, "prev_rseed": -1621482058762806649, "prev round vrf random seed": "-1680a9576a39e579", "bls_msg": "1796970-1680a9576a39e579"} 2025-11-10T00:49:27.617Z INFO miner/protocol_bls.go:364 DKG AddVRFShare {"round": 179697, "round_vrf_num": 1, "threshold": 2, "sender": 0, "round_timeout_count": 0, "vrf_timeout_count": 0, "vrf_share": "1 12c57df24167b442c182ee9c0592afadb4d52ca641db9ff6d7f41dcf2950564e 1de83131a1a8323536474afaafa1e1e460c21db41596d8270dd18449aa99865f"} 2025-11-10T00:49:27.617Z DEBUG miner/protocol_receive.go:26 handle vrf share {"round": 179697, "vrf_timeout_count": 0, "sender_index": 0} 2025-11-10T00:49:27.617Z DEBUG miner/worker.go:53 message {"msg": {"code":"vrf_share","value":"VRF Share"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71"} 2025-11-10T00:49:27.611Z INFO chain/entity.go:1721 delete blocks below round {"round": 179697, "below_round": 179643, "before": 1762735707, "total": 310, "count": 0} 2025-11-10T00:49:27.611Z DEBUG chain/protocol_round.go:334 finalize round - block has less than 3 confirmation 2025-11-10T00:49:27.610Z DEBUG chain/protocol_round.go:334 finalize round - block has less than 3 confirmation 2025-11-10T00:49:27.610Z INFO chain/protocol_round.go:402 finalize round - finalize block success {"round": 179693, "block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681", "duration": "4.066079ms"} 2025-11-10T00:49:27.610Z DEBUG chain/worker.go:230 finalize block processed {"round": 179693, "duration": "4.027768ms"} 2025-11-10T00:49:27.610Z DEBUG chain/protocol_block.go:612 finalized block - done {"round": 179693, "block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681", "duration": "3.923066ms"} 2025-11-10T00:49:27.610Z INFO chain/entity.go:2366 config has been updated successfully {"start of round": 179693} 2025-11-10T00:49:27.610Z INFO memorystore/collection.go:65 Redis returned 0 rows after seclect 2025-11-10T00:49:27.610Z 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-10T00:49:27.610Z DEBUG transaction/worker.go:253 [mvc] see no old txns {"clientID": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "nonce": 92490} 2025-11-10T00:49:27.610Z INFO memorystore/collection.go:65 Redis returned 0 rows after seclect 2025-11-10T00:49:27.610Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\ufffd-<1n\ufffd\ufffdD\ufffd\ufffdå\ufffd\u0017\ufffd\t\ufffd\u001eE\ufffd]\ufffd\ufffd\u0001\ufffd\ufffdƈ;\ufffdx"} 2025-11-10T00:49:27.610Z DEBUG transaction/worker.go:221 [mvc] remove old nonce txns {"clientID": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "nonce": 92490} 2025-11-10T00:49:27.610Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\u001c\ufffd\ufffd\u0011\u0017}\ufffd\ufffd\ufffdQ\ufffd\ufffd4\ufffd<\ufffd\ufffdT\ufffd\ufffdbһ5/6t\ufffdz\ufffd\ufffdV"} 2025-11-10T00:49:27.610Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "E|\u0013\ufffd\tJ\t\ufffdZ9΃\u000cݔ\u0000@x\ufffdS\ufffd!R\u0001\ufffdCt\ufffdP\u0011d\u0005"} 2025-11-10T00:49:27.609Z DEBUG chain/lfb_round_node.go:33 [mvc] store lfb {"round": 179693, "block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681", "mb number": 1} 2025-11-10T00:49:27.609Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\u0012\u0001\ufffd\ufffd\ufffd\ufffd\ufffd]o\u0013?\ufffd\ufffd_\ufffd۾\ufffdS\u0010\ufffd#\ufffd&l\ufffd\r\n\ufffd\ufffd\u001d2"} 2025-11-10T00:49:27.609Z DEBUG chain/worker.go:443 BC is moving {"current_lfb_round": 179693, "last_round": 179692} 2025-11-10T00:49:27.609Z DEBUG chain/entity.go:2269 set lfb {"round": 179693, "block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681", "state_computed": true} 2025-11-10T00:49:27.609Z DEBUG chain/state.go:128 finalize round - rebased current state db {"round": 179693, "block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681", "state hash": "50d056c1e4539c976a2fc0c7f11be0553b16a2a4db8f7071e14873539f761761"} 2025-11-10T00:49:27.609Z INFO transaction/worker.go:164 cleaning transactions {"collection": "collection.txn:0afc093ffb509f059c55478bc1a60351cef7b4e9c008a53a6cc8241ca8617dfe", "missing_count": 1, "txns": ["7be4d61f00a002b0c1f4348681d7859f1f9a8acce49362cb2c4a32154c4b1f91"], "past txns": []} 2025-11-10T00:49:27.609Z INFO memorystore/collection.go:65 Redis returned 0 rows after seclect 2025-11-10T00:49:27.609Z DEBUG util/mpt_nodedb.go:556 LevelNodeDB rebase db 2025-11-10T00:49:27.609Z DEBUG chain/protocol_block.go:424 finalize block - record dead nodes {"round": 179693, "block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681", "num dead nodes": 9} 2025-11-10T00:49:27.609Z DEBUG transaction/worker.go:124 cleaning past transactions 2025-11-10T00:49:27.609Z DEBUG miner/round.go:238 Round clear - cancel verification 2025-11-10T00:49:27.609Z DEBUG miner/chain.go:313 delete txns {"txns": ["7be4d61f00a002b0c1f4348681d7859f1f9a8acce49362cb2c4a32154c4b1f91"]} 2025-11-10T00:49:27.609Z INFO miner/protocol_block.go:619 update finalized block (debug transaction) {"txn": "7be4d61f00a002b0c1f4348681d7859f1f9a8acce49362cb2c4a32154c4b1f91", "block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681"} 2025-11-10T00:49:27.609Z INFO miner/protocol_block.go:613 update finalized block {"round": 179693, "block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681", "lf_round": 179692, "current_round": 179697, "weight": 1} 2025-11-10T00:49:27.608Z DEBUG chain/protocol_block.go:409 MPT state node stat - inc {"node num": -342567, "change num": 9, "delete num": 9} 2025-11-10T00:49:27.608Z INFO block/entity.go:1195 save state {"round": 179693, "block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681", "block_size": 1, "changes": 9, "client_state": "50d056c1e4539c976a2fc0c7f11be0553b16a2a4db8f7071e14873539f761761", "duration": "1.40431ms"} 2025-11-10T00:49:27.608Z DEBUG util/merkle_patricia_trie.go:272 MPT save changes success {"duration": "982.594µs"} 2025-11-10T00:49:27.608Z DEBUG util/mpt_node_change.go:156 MPT - update changes done {"changes": 9} 2025-11-10T00:49:27.608Z INFO miner/protocol_bls.go:489 Not yet reached threshold {"vrfShares_num": 1, "threshold": 2, "round": 179697} 2025-11-10T00:49:27.608Z DEBUG round/entity.go:684 add_vrf_share {"round": 179697, "round_vrf_num": 1, "threshold": 2} 2025-11-10T00:49:27.608Z INFO miner/protocol_bls.go:430 verified vrf {"round": 179697, "node_id": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "share": "1 de7d4f1ccc5000d40d5775af006d1f331bbf6949e0391ed1b00d1f17c2fae43 1c4fb55fe7cd0c27b7cf24ce0c7947413867be6ec7983ba10b12d92bae671b4", "from": "1c3227e496fdf3c9aa604f3470a2bbd1", "message": "1796970-1680a9576a39e579"} 2025-11-10T00:49:27.607Z DEBUG util/mpt_node_change.go:150 MPT - update changes {"changes": 9} 2025-11-10T00:49:27.607Z DEBUG bls/dkg.go:396 dkg verify {"id": "1c3227e496fdf3c9aa604f3470a2bbd1", "key": "1 6603e20478fac2c72a61b85056977b92696b8fffd408d8acac0e1f47aed3f96 1501242ed9000d9c6a02764160261164a52360a692c34ed452ff097bc90ee9b3 7f8aaa178d31fa4cbd0c1974768dfa4921e29405754ebf8d2c163a774b741a2 24515e04bd685a5559260f5d1868e5ea11abaf21f55a56aee52c15d9f3c2b053", "msg": "1796970-1680a9576a39e579", "sig": "1 de7d4f1ccc5000d40d5775af006d1f331bbf6949e0391ed1b00d1f17c2fae43 1c4fb55fe7cd0c27b7cf24ce0c7947413867be6ec7983ba10b12d92bae671b4"} 2025-11-10T00:49:27.607Z INFO round/entity.go:618 get miners by rank {"num_miners": 3, "round": 179693, "r.minerPerm": [0, 2, 1]} 2025-11-10T00:49:27.606Z INFO chain/protocol_block.go:363 finalize block -- round {"round": {"number":179693,"round_random_seed":1522649934855760679,"block_hash":"9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681","vrf_output":"15218a0c64596b27ed4f09fc5f8cce8f2982ec14b8ec1d4a425ffab6e3af837f"}, "block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681"} 2025-11-10T00:49:27.607Z INFO miner/protocol_bls.go:265 BLS sign VRF share calculated for {"round": 179697, "round_timeout": 0, "prev_rseed": -1621482058762806649, "prev round vrf random seed": "-1680a9576a39e579", "bls_msg": "1796970-1680a9576a39e579"} 2025-11-10T00:49:27.607Z INFO miner/protocol_bls.go:364 DKG AddVRFShare {"round": 179697, "round_vrf_num": 0, "threshold": 2, "sender": 2, "round_timeout_count": 0, "vrf_timeout_count": 0, "vrf_share": "1 de7d4f1ccc5000d40d5775af006d1f331bbf6949e0391ed1b00d1f17c2fae43 1c4fb55fe7cd0c27b7cf24ce0c7947413867be6ec7983ba10b12d92bae671b4"} 2025-11-10T00:49:27.606Z INFO miner/protocol_round.go:78 add_my_vrf_share {"round": 179697, "round_timeout": 0, "dkg_starting_round": 0, "dkg_mb_number": 1, "pr_seed": -1621482058762806649, "pr_vrf_seed": "-1680a9576a39e579", "share": "1 de7d4f1ccc5000d40d5775af006d1f331bbf6949e0391ed1b00d1f17c2fae43 1c4fb55fe7cd0c27b7cf24ce0c7947413867be6ec7983ba10b12d92bae671b4"} 2025-11-10T00:49:27.606Z DEBUG miner/protocol_bls.go:305 get_bls_share {"round": 179697, "rtc": 0, "dkg_pi": "1 6603e20478fac2c72a61b85056977b92696b8fffd408d8acac0e1f47aed3f96 1501242ed9000d9c6a02764160261164a52360a692c34ed452ff097bc90ee9b3 7f8aaa178d31fa4cbd0c1974768dfa4921e29405754ebf8d2c163a774b741a2 24515e04bd685a5559260f5d1868e5ea11abaf21f55a56aee52c15d9f3c2b053", "dkg_sr": 0, "mb_sr": 0, "share": "1 de7d4f1ccc5000d40d5775af006d1f331bbf6949e0391ed1b00d1f17c2fae43 1c4fb55fe7cd0c27b7cf24ce0c7947413867be6ec7983ba10b12d92bae671b4"} 2025-11-10T00:49:27.606Z INFO chain/protocol_block.go:328 finalize block {"round": 179693, "current_round": 179697, "lf_round": 179692, "hash": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681", "round_rank": 0, "state": 7} 2025-11-10T00:49:27.606Z DEBUG chain/worker.go:262 start to finalize block {"round": 179693, "block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681", "prev block": "a5a02e57890ea331e739756d6aae95ddbc38ad762eea55963a4ad535152dc249"} 2025-11-10T00:49:27.606Z INFO chain/protocol_round.go:359 finalize round {"round": 179693, "lfb round": 179695, "block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681"} 2025-11-10T00:49:27.606Z INFO chain/protocol_round.go:326 finalize round - latest finalized round {"round": 179696, "lfb round": 179695, "lfb block": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db"} 2025-11-10T00:49:27.606Z INFO chain/protocol_round.go:199 finalize round {"round": 179696, "plfb_round": 179692, "num_round_notarized": 1, "num_chain_notarized": 3} 2025-11-10T00:49:27.606Z DEBUG chain/protocol_round.go:160 finalize round {"round": 179696, "lf_round": 179692} 2025-11-10T00:49:27.606Z DEBUG bls/dkg.go:356 dkg sign {"key": "21d97039e984194d599f2bf60c03d185c67ff756eba44a56ac9cf108c33c814a", "pi": "1 6603e20478fac2c72a61b85056977b92696b8fffd408d8acac0e1f47aed3f96 1501242ed9000d9c6a02764160261164a52360a692c34ed452ff097bc90ee9b3 7f8aaa178d31fa4cbd0c1974768dfa4921e29405754ebf8d2c163a774b741a2 24515e04bd685a5559260f5d1868e5ea11abaf21f55a56aee52c15d9f3c2b053"} 2025-11-10T00:49:27.606Z DEBUG miner/protocol_bls.go:293 Sign msg with dkg {"msg": "1796970-1680a9576a39e579", "round": 179697, "dkg starting round": 0} 2025-11-10T00:49:27.606Z INFO miner/protocol_bls.go:265 BLS sign VRF share calculated for {"round": 179697, "round_timeout": 0, "prev_rseed": -1621482058762806649, "prev round vrf random seed": "-1680a9576a39e579", "bls_msg": "1796970-1680a9576a39e579"} 2025-11-10T00:49:27.606Z INFO miner/protocol_bls.go:283 DKG getBlsShare {"Round Number": 179697} 2025-11-10T00:49:27.606Z INFO miner/protocol_round.go:244 StartNextRound - add VRF {"round": 179697} 2025-11-10T00:49:27.606Z INFO miner/round.go:40 Try to cancel block generation that have not been started yet {"round": 179696} 2025-11-10T00:49:27.606Z DEBUG miner/protocol_round.go:210 finalizedRound - cancel round verification {"round": 179696} 2025-11-10T00:49:27.606Z INFO chain/entity.go:2016 Moving to the next round {"next_round": 179697} 2025-11-10T00:49:27.606Z DEBUG miner/protocol_round.go:154 [wait not ahead] [2] not ahead, can move on {"round": 179696, "lfb tk round": 179692} 2025-11-10T00:49:27.606Z DEBUG miner/protocol_round.go:991 verification_complete {"top_verified_rank": 0} 2025-11-10T00:49:27.606Z DEBUG miner/protocol_round.go:123 [wait not ahead] 2025-11-10T00:49:27.606Z INFO miner/protocol_round.go:986 verification_complete {"round": 179696, "verified_blocks": 0} 2025-11-10T00:49:27.606Z DEBUG miner/protocol_round.go:943 verifyAndSend - finished successfully {"round": 179696, "block": "14482f721677a955910a55bd0cdd44f655d2497180061be5d9cd6ae0f187c922"} 2025-11-10T00:49:27.606Z INFO miner/round.go:40 Try to cancel block generation that have not been started yet {"round": 179696} 2025-11-10T00:49:27.606Z INFO miner/round.go:230 Cancelling verification {"round": 179696} 2025-11-10T00:49:27.606Z INFO miner/protocol_receive.go:456 process notarization - start next round {"new round": 179697} 2025-11-10T00:49:27.606Z DEBUG miner/protocol_round.go:1149 check block notarization - block notarized {"round": 179696, "block": "14482f721677a955910a55bd0cdd44f655d2497180061be5d9cd6ae0f187c922"} 2025-11-10T00:49:27.606Z DEBUG round/entity.go:344 reached notarization {"round": 179696} 2025-11-10T00:49:27.606Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 179696, "randk": 0, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T00:49:27.606Z INFO chain/entity.go:1571 Adding a notarized block for current round {"Round": 179696} 2025-11-10T00:49:27.606Z INFO chain/protocol_block.go:303 reached notarization - add tickets {"round": 179696, "current_round": 179696, "block": "14482f721677a955910a55bd0cdd44f655d2497180061be5d9cd6ae0f187c922", "tickets_num": 2} 2025-11-10T00:49:27.606Z INFO miner/protocol_round.go:920 verifyAndSend - sending verification ticket {"round": 179696, "block": "14482f721677a955910a55bd0cdd44f655d2497180061be5d9cd6ae0f187c922", "block_rank": 0, "RRS": -1621482058762806649} 2025-11-10T00:49:27.606Z INFO chain/protocol_block.go:319 reached notarization - merging tickets {"round": 179695, "current_round": 179696, "block": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db", "tickets_num": 3} 2025-11-10T00:49:27.605Z DEBUG miner/protocol_round.go:1069 verify round block - finished verification {"block": "14482f721677a955910a55bd0cdd44f655d2497180061be5d9cd6ae0f187c922"} 2025-11-10T00:49:27.605Z INFO miner/protocol_block.go:376 verify block successful {"round": 179696, "block_size": 2, "time": "16.866566ms", "block": "14482f721677a955910a55bd0cdd44f655d2497180061be5d9cd6ae0f187c922", "prev_block": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db", "state_hash": "5b1f334944f259548b7486067e4f2e2be904300697b5b65adee835dd5d3c3298", "state_status": 4} 2025-11-10T00:49:27.605Z DEBUG miner/protocol_block.go:374 SignBlock finished {"block": "14482f721677a955910a55bd0cdd44f655d2497180061be5d9cd6ae0f187c922", "spent": "181.022µs"} 2025-11-10T00:49:27.605Z DEBUG miner/protocol_block.go:367 VerifyBlockMagicBlock finished {"block": "14482f721677a955910a55bd0cdd44f655d2497180061be5d9cd6ae0f187c922", "spent": "480ns"} 2025-11-10T00:49:27.605Z DEBUG miner/protocol_block.go:360 verifySmartContracts finished {"block": "14482f721677a955910a55bd0cdd44f655d2497180061be5d9cd6ae0f187c922", "spent": "4.81µs"} 2025-11-10T00:49:27.605Z DEBUG miner/protocol_block.go:351 verify block - ComputeState finished {"round": 179696, "block": "14482f721677a955910a55bd0cdd44f655d2497180061be5d9cd6ae0f187c922", "spent": "11.971744ms"} 2025-11-10T00:49:27.605Z INFO block/entity.go:1034 compute state successful {"round": 179696, "block": "14482f721677a955910a55bd0cdd44f655d2497180061be5d9cd6ae0f187c922", "block ptr": "0xc01a495a40", "block_size": 2, "duration": "11.898833ms", "changes": 9, "begin_client_state": "f48182ce8560cf2333eafc6679725ebb434d57da56b453e9972c6c25fcc684c0", "computed_state_hash": "5b1f334944f259548b7486067e4f2e2be904300697b5b65adee835dd5d3c3298", "block_state_hash": "5b1f334944f259548b7486067e4f2e2be904300697b5b65adee835dd5d3c3298", "prev_block": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db", "prev_block_client_state": "f48182ce8560cf2333eafc6679725ebb434d57da56b453e9972c6c25fcc684c0"} 2025-11-10T00:49:27.605Z DEBUG statecache/statecache.go:131 statecache - commit {"block": "14482f721677a955910a55bd0cdd44f655d2497180061be5d9cd6ae0f187c922", "bc_hits": 76, "bc_miss": 0, "sc_hits": 16632462, "sc_miss": 4957, "duration": "363.576µs"} 2025-11-10T00:49:27.604Z DEBUG chain/state.go:961 Updating nonce {"client": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "new_nonce": 91627} 2025-11-10T00:49:27.604Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T00:49:27.604Z INFO chain/state.go:533 SC executed {"client id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "block": "14482f721677a955910a55bd0cdd44f655d2497180061be5d9cd6ae0f187c922", "round": 179696, "prev_state_hash": "f48182ce8560cf2333eafc6679725ebb434d57da56b453e9972c6c25fcc684c0", "txn_hash": "6832d9473687a4234177b3c8eeda8140d3655b4a53c886338d1c8af2f86ad4fb", "txn_nonce": 91627, "txn_func": "generate_challenge", "txn_status": 1, "txn_exec_time": "355.635µs", "begin client state": "be51e0618a2de2ec5e557e68f46e6fdf3c81d11a928f4593127a40dcd3b0a601", "current_root": "be51e0618a2de2ec5e557e68f46e6fdf3c81d11a928f4593127a40dcd3b0a601", "mpt_cache_hit": 9, "mpt_cache_miss": 0, "output": "OpenChallenges generated"} 2025-11-10T00:49:27.604Z INFO storagesc/challenge.go:1191 skipping generate challenge: empty blobber challenge partition 2025-11-10T00:49:27.604Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "eaf4195ad8a6c0bd8f90e9b28f4ba3b4938ddc60155952285997f669446bb502"} 2025-11-10T00:49:27.603Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T00:49:27.602Z DEBUG chain/state.go:961 Updating nonce {"client": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "new_nonce": 91626} 2025-11-10T00:49:27.602Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T00:49:27.602Z INFO chain/state.go:533 SC executed {"client id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "block": "14482f721677a955910a55bd0cdd44f655d2497180061be5d9cd6ae0f187c922", "round": 179696, "prev_state_hash": "f48182ce8560cf2333eafc6679725ebb434d57da56b453e9972c6c25fcc684c0", "txn_hash": "8da4af607f4bb2547186c7ee5be26bc065c1053caa5e082daaa8ed6244008441", "txn_nonce": 91626, "txn_func": "payFees", "txn_status": 1, "txn_exec_time": "8.130768ms", "begin client state": "f48182ce8560cf2333eafc6679725ebb434d57da56b453e9972c6c25fcc684c0", "current_root": "7af9436a75d4d6123513f95dc8e5d9bab2eeb35a99b982b8b2981f40bda294eb", "mpt_cache_hit": 43, "mpt_cache_miss": 0, "output": ""} 2025-11-10T00:49:27.601Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T00:49:27.601Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T00:49:27.600Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T00:49:27.600Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T00:49:27.594Z ERROR minersc/global_node.go:372 failed to get current magic block {"error": "value not present"} 0chain.net/smartcontract/minersc.(*GlobalNode).prevMagicBlock /0chain/code/go/0chain.net/smartcontract/minersc/global_node.go:372 0chain.net/smartcontract/minersc.getRegisterShardersInMagicBlock /0chain/code/go/0chain.net/smartcontract/minersc/fees.go:659 0chain.net/smartcontract/minersc.(*MinerSmartContract).payFees /0chain/code/go/0chain.net/smartcontract/minersc/fees.go:519 0chain.net/smartcontract/minersc.(*MinerSmartContract).Execute /0chain/code/go/0chain.net/smartcontract/minersc/sc.go:139 0chain.net/chaincore/smartcontract.ExecuteWithStats /0chain/code/go/0chain.net/chaincore/smartcontract/handler.go:52 0chain.net/chaincore/smartcontract.ExecuteSmartContract /0chain/code/go/0chain.net/chaincore/smartcontract/handler.go:67 0chain.net/chaincore/chain.(*Chain).ExecuteSmartContract.func1 /0chain/code/go/0chain.net/chaincore/chain/state.go:158 2025-11-10T00:49:27.594Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "6dba10422e368813802877a85039d3985d96760ed844092319743fb3a76712d9d2208fe938b7465b9c5dc571053986cf8dbf3585fb36399f98ea569c42f50b76"} 2025-11-10T00:49:27.594Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "6dba10422e368813802877a85039d3985d96760ed844092319743fb3a76712d9b5e8a1650666fdd3a9de7855b6da63ab629b1701f23738477e2325f7ca2150ac"} 2025-11-10T00:49:27.594Z DEBUG minersc/fees.go:480 pay_fees, got miner id successfully {"miner id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "round": 179696, "block": "14482f721677a955910a55bd0cdd44f655d2497180061be5d9cd6ae0f187c922"} 2025-11-10T00:49:27.594Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T00:49:27.594Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T00:49:27.593Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T00:49:27.593Z DEBUG miner/protocol_block.go:339 ValidateBlockCost {"round": 179696, "hash": "14482f721677a955910a55bd0cdd44f655d2497180061be5d9cd6ae0f187c922", "calculated cost": 100} 2025-11-10T00:49:27.593Z DEBUG statecache/statecache.go:173 state cache - see gap {"block": "0a1d0709e7b36484236f49ba15512201289834420ea9115ff09c91df3763330c"} 2025-11-10T00:49:27.592Z DEBUG statecache/statecache.go:173 state cache - see gap {"block": "0a1d0709e7b36484236f49ba15512201289834420ea9115ff09c91df3763330c"} 2025-11-10T00:49:27.592Z DEBUG statecache/statecache.go:173 state cache - see gap {"block": "0a1d0709e7b36484236f49ba15512201289834420ea9115ff09c91df3763330c"} 2025-11-10T00:49:27.592Z DEBUG miner/protocol_block.go:305 ValidateTransactions finished {"block": "14482f721677a955910a55bd0cdd44f655d2497180061be5d9cd6ae0f187c922", "spent": "2.144422ms"} 2025-11-10T00:49:27.592Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"verification_ticket","value":"Verification Ticket"}, "sender_index": 0, "id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "duration": "1.442641ms"} 2025-11-10T00:49:27.592Z INFO miner/protocol_round.go:1127 checkBlockNotarization -- block is not Notarized. Returning {"round": 179696, "block hash": "14482f721677a955910a55bd0cdd44f655d2497180061be5d9cd6ae0f187c922"} 2025-11-10T00:49:27.592Z INFO chain/protocol_block.go:225 not reached notarization {"mb_sr": 0, "active_miners": 3, "threshold": 2, "num_signatures": 1, "current_round": 179696, "round": 179696} 2025-11-10T00:49:27.592Z DEBUG miner/protocol_receive.go:298 handle vt. msg - verify ticket successfully {"round": 179696, "block": "14482f721677a955910a55bd0cdd44f655d2497180061be5d9cd6ae0f187c922", "verifier": 1} 2025-11-10T00:49:27.590Z DEBUG miner/worker.go:53 message {"msg": {"code":"verification_ticket","value":"Verification Ticket"}, "sender_index": 0, "id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341"} 2025-11-10T00:49:27.590Z DEBUG miner/protocol_block.go:299 GetPreviousBlock finished {"block": "14482f721677a955910a55bd0cdd44f655d2497180061be5d9cd6ae0f187c922", "spent": "1.22µs"} 2025-11-10T00:49:27.590Z DEBUG miner/protocol_block.go:292 VerifyBlockMagicBlockReference finished {"block": "14482f721677a955910a55bd0cdd44f655d2497180061be5d9cd6ae0f187c922", "spent": "3.03µs"} 2025-11-10T00:49:27.590Z DEBUG miner/protocol_block.go:286 Validating finished {"block": "14482f721677a955910a55bd0cdd44f655d2497180061be5d9cd6ae0f187c922", "spent": "957.774µs"} 2025-11-10T00:49:27.589Z DEBUG miner/m_handler.go:365 handle vt. msg - verification ticket {"round": 179696, "block": "14482f721677a955910a55bd0cdd44f655d2497180061be5d9cd6ae0f187c922"} 2025-11-10T00:49:27.589Z DEBUG chain/entity.go:440 process block, no block in buffer {"current round": 179696} 2025-11-10T00:49:27.589Z DEBUG miner/protocol_round.go:1067 verify round block - started verification {"block": "14482f721677a955910a55bd0cdd44f655d2497180061be5d9cd6ae0f187c922"} 2025-11-10T00:49:27.589Z DEBUG miner/protocol_round.go:1040 verify round block {"round": 179696, "block": "14482f721677a955910a55bd0cdd44f655d2497180061be5d9cd6ae0f187c922"} 2025-11-10T00:49:27.589Z DEBUG miner/protocol_round.go:865 verifyAndSend - started {"block": "14482f721677a955910a55bd0cdd44f655d2497180061be5d9cd6ae0f187c922"} 2025-11-10T00:49:27.589Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 179696, "randk": 1, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T00:49:27.588Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 179696, "randk": 0, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T00:49:27.588Z INFO miner/protocol_round.go:951 Started main verification loop {"round": 179696} 2025-11-10T00:49:27.562Z DEBUG chain/protocol_lfb_ticket.go:386 update lfb ticket - ticket.Round <= latest.Round {"ticket.Round": 179692, "latest.Round": 179692} 2025-11-10T00:49:27.555Z DEBUG chain/protocol_lfb_ticket.go:386 update lfb ticket - ticket.Round <= latest.Round {"ticket.Round": 179692, "latest.Round": 179692} 2025-11-10T00:49:27.493Z INFO miner/worker.go:187 round worker: got_timeout {"next": 1500} 2025-11-10T00:49:27.493Z INFO miner/protocol_round.go:1322 nextTimeout {"tick": 1500} 2025-11-10T00:49:27.489Z DEBUG chain/entity.go:440 process block, no block in buffer {"current round": 179696} 2025-11-10T00:49:27.430Z DEBUG miner/protocol_round.go:1028 verify block - pending {"round": 179696, "block": "2eab930eb8854af2eea6170024b46b9bbca5714e2299b65afc756d0a7c882170"} 2025-11-10T00:49:27.430Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 179696, "randk": 1, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T00:49:27.430Z DEBUG miner/protocol_receive.go:130 verify block processed {"round": 179696, "block": "2eab930eb8854af2eea6170024b46b9bbca5714e2299b65afc756d0a7c882170"} 2025-11-10T00:49:27.430Z DEBUG miner/round.go:143 Adding block to verifyChannel {"round": 179696, "block hash": "2eab930eb8854af2eea6170024b46b9bbca5714e2299b65afc756d0a7c882170", "magic block": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "magic block round": 0} 2025-11-10T00:49:27.430Z INFO miner/protocol_round.go:803 adding block to verify {"round": 179696, "block": "2eab930eb8854af2eea6170024b46b9bbca5714e2299b65afc756d0a7c882170", "prev_block": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db", "state_hash": "c2409a815dedadeeb0d74b40e46e240323d1b0a4e88e0cd39043f9174a2cc7d5", "weight": 1} 2025-11-10T00:49:27.430Z INFO chain/protocol_block.go:319 reached notarization - merging tickets {"round": 179695, "current_round": 179696, "block": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db", "tickets_num": 3} 2025-11-10T00:49:27.430Z DEBUG miner/protocol_round.go:759 update prev block notarization, already notarized {"round": 179695, "block": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db"} 2025-11-10T00:49:27.430Z INFO miner/protocol_round.go:613 handle verify block - added block for ticket verification {"round": 179696, "block": "2eab930eb8854af2eea6170024b46b9bbca5714e2299b65afc756d0a7c882170", "magic block": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "magic block round": 0} 2025-11-10T00:49:27.430Z INFO chain/protocol_block.go:225 not reached notarization {"mb_sr": 0, "active_miners": 3, "threshold": 2, "num_signatures": 0, "current_round": 179696, "round": 179696} 2025-11-10T00:49:27.429Z DEBUG miner/protocol_receive.go:169 verify block {"round": 179696, "block": "2eab930eb8854af2eea6170024b46b9bbca5714e2299b65afc756d0a7c882170"} 2025-11-10T00:49:27.429Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"verify_block","value":"Verify Block"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "duration": "57.251µs"} 2025-11-10T00:49:27.429Z DEBUG miner/worker.go:53 message {"msg": {"code":"verify_block","value":"Verify Block"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71"} 2025-11-10T00:49:27.424Z DEBUG miner/protocol_round.go:1028 verify block - pending {"round": 179696, "block": "14482f721677a955910a55bd0cdd44f655d2497180061be5d9cd6ae0f187c922"} 2025-11-10T00:49:27.424Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 179696, "randk": 0, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T00:49:27.424Z DEBUG miner/protocol_receive.go:130 verify block processed {"round": 179696, "block": "14482f721677a955910a55bd0cdd44f655d2497180061be5d9cd6ae0f187c922"} 2025-11-10T00:49:27.424Z DEBUG miner/round.go:143 Adding block to verifyChannel {"round": 179696, "block hash": "14482f721677a955910a55bd0cdd44f655d2497180061be5d9cd6ae0f187c922", "magic block": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "magic block round": 0} 2025-11-10T00:49:27.424Z DEBUG miner/protocol_round.go:759 update prev block notarization, already notarized {"round": 179695, "block": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db"} 2025-11-10T00:49:27.424Z INFO miner/protocol_round.go:803 adding block to verify {"round": 179696, "block": "14482f721677a955910a55bd0cdd44f655d2497180061be5d9cd6ae0f187c922", "prev_block": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db", "state_hash": "5b1f334944f259548b7486067e4f2e2be904300697b5b65adee835dd5d3c3298", "weight": 1} 2025-11-10T00:49:27.424Z INFO miner/protocol_round.go:613 handle verify block - added block for ticket verification {"round": 179696, "block": "14482f721677a955910a55bd0cdd44f655d2497180061be5d9cd6ae0f187c922", "magic block": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "magic block round": 0} 2025-11-10T00:49:27.424Z INFO chain/protocol_block.go:225 not reached notarization {"mb_sr": 0, "active_miners": 3, "threshold": 2, "num_signatures": 0, "current_round": 179696, "round": 179696} 2025-11-10T00:49:27.423Z DEBUG miner/protocol_receive.go:169 verify block {"round": 179696, "block": "14482f721677a955910a55bd0cdd44f655d2497180061be5d9cd6ae0f187c922"} 2025-11-10T00:49:27.423Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"verify_block","value":"Verify Block"}, "sender_index": 0, "id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "duration": "59.081µs"} 2025-11-10T00:49:27.423Z DEBUG miner/worker.go:53 message {"msg": {"code":"verify_block","value":"Verify Block"}, "sender_index": 0, "id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341"} 2025-11-10T00:49:27.410Z INFO miner/m_handler.go:242 Reject VRFShare: VRF is complete for this round {"vrfs_round_num": 179696, "vrfs_sender_index": 0, "vrfs_round_num": 179696} 2025-11-10T00:49:27.409Z INFO miner/m_handler.go:242 Reject VRFShare: VRF is complete for this round {"vrfs_round_num": 179696, "vrfs_sender_index": 0, "vrfs_round_num": 179696} 2025-11-10T00:49:27.409Z INFO chain/entity.go:1721 delete blocks below round {"round": 179696, "below_round": 179642, "before": 1762735707, "total": 309, "count": 0} 2025-11-10T00:49:27.409Z DEBUG chain/protocol_round.go:334 finalize round - block has less than 3 confirmation 2025-11-10T00:49:27.409Z DEBUG chain/protocol_round.go:334 finalize round - block has less than 3 confirmation 2025-11-10T00:49:27.409Z INFO chain/protocol_round.go:402 finalize round - finalize block success {"round": 179692, "block": "a5a02e57890ea331e739756d6aae95ddbc38ad762eea55963a4ad535152dc249", "duration": "4.292432ms"} 2025-11-10T00:49:27.409Z DEBUG chain/worker.go:230 finalize block processed {"round": 179692, "duration": "4.243052ms"} 2025-11-10T00:49:27.409Z DEBUG chain/protocol_block.go:612 finalized block - done {"round": 179692, "block": "a5a02e57890ea331e739756d6aae95ddbc38ad762eea55963a4ad535152dc249", "duration": "4.11555ms"} 2025-11-10T00:49:27.409Z INFO chain/entity.go:2366 config has been updated successfully {"start of round": 179692} 2025-11-10T00:49:27.408Z 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-10T00:49:27.408Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\ufffd-<1n\ufffd\ufffdD\ufffd\ufffdå\ufffd\u0017\ufffd\t\ufffd\u001eE\ufffd]\ufffd\ufffd\u0001\ufffd\ufffdƈ;\ufffdx"} 2025-11-10T00:49:27.408Z DEBUG transaction/worker.go:253 [mvc] see no old txns {"clientID": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "nonce": 92490} 2025-11-10T00:49:27.408Z INFO memorystore/collection.go:65 Redis returned 0 rows after seclect 2025-11-10T00:49:27.408Z DEBUG chain/lfb_round_node.go:33 [mvc] store lfb {"round": 179692, "block": "a5a02e57890ea331e739756d6aae95ddbc38ad762eea55963a4ad535152dc249", "mb number": 1} 2025-11-10T00:49:27.408Z DEBUG chain/worker.go:443 BC is moving {"current_lfb_round": 179692, "last_round": 179691} 2025-11-10T00:49:27.408Z DEBUG transaction/worker.go:221 [mvc] remove old nonce txns {"clientID": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "nonce": 92490} 2025-11-10T00:49:27.408Z DEBUG chain/entity.go:2269 set lfb {"round": 179692, "block": "a5a02e57890ea331e739756d6aae95ddbc38ad762eea55963a4ad535152dc249", "state_computed": true} 2025-11-10T00:49:27.408Z INFO miner/protocol_round.go:830 Starting round verification {"round": 179696, "delta": "180ms"} 2025-11-10T00:49:27.408Z DEBUG chain/state.go:128 finalize round - rebased current state db {"round": 179692, "block": "a5a02e57890ea331e739756d6aae95ddbc38ad762eea55963a4ad535152dc249", "state hash": "6eb5ce484c6bd27d023c212e12da26da62b40351f4a8e9632461df347e8fd95e"} 2025-11-10T00:49:27.408Z INFO round/entity.go:618 get miners by rank {"num_miners": 3, "round": 179696, "r.minerPerm": [1, 0, 2]} 2025-11-10T00:49:27.408Z INFO miner/protocol_round.go:322 TOC_FIX Not a generator {"round": 179696, "index": 2, "rank": 2, "timeout_count": 0, "random_seed": -1621482058762806649} 2025-11-10T00:49:27.408Z DEBUG util/mpt_nodedb.go:556 LevelNodeDB rebase db 2025-11-10T00:49:27.408Z INFO miner/protocol_bls.go:591 Starting round with vrf {"round": 179696, "roundtimeout": 0, "rseed": -1621482058762806649, "prev_round": 179695, "Prev_rseed": 0} 2025-11-10T00:49:27.408Z INFO transaction/worker.go:164 cleaning transactions {"collection": "collection.txn:0afc093ffb509f059c55478bc1a60351cef7b4e9c008a53a6cc8241ca8617dfe", "missing_count": 2, "txns": ["de0be397e42db64597c3896c729875ec01f5c8573a42231a0e472a5c8a1abe8f", "1abc41b23654f171aff2ce4b449cf99d1709708a436f1b827dbddc6a40ca2cbd"], "past txns": []} 2025-11-10T00:49:27.408Z INFO memorystore/collection.go:65 Redis returned 0 rows after seclect 2025-11-10T00:49:27.408Z DEBUG chain/protocol_block.go:424 finalize block - record dead nodes {"round": 179692, "block": "a5a02e57890ea331e739756d6aae95ddbc38ad762eea55963a4ad535152dc249", "num dead nodes": 15} 2025-11-10T00:49:27.408Z DEBUG miner/protocol_bls.go:542 DKG computeRBO {"round": 179696} 2025-11-10T00:49:27.407Z INFO miner/protocol_bls.go:524 receive bls sign {"round": 179696, "group_signature": "1 110d53a05dbf8d0c14a11a812ce40a086a2b37e8821a3d8750fda844c76c4339 1277ff8840341a560a12a1ce940f0c7135a4c39cc872e417de0a009d02c4ffd0", "rboOutput": "e97f56a895c61a87c4c9b4d3db935e0cbe7278adf2f33732ec5475eb3d5be430", "dkg_starting_round": 0, "dkg_mb_number": 1} 2025-11-10T00:49:27.407Z DEBUG transaction/worker.go:124 cleaning past transactions 2025-11-10T00:49:27.407Z DEBUG miner/round.go:238 Round clear - cancel verification 2025-11-10T00:49:27.407Z DEBUG miner/chain.go:313 delete txns {"txns": ["de0be397e42db64597c3896c729875ec01f5c8573a42231a0e472a5c8a1abe8f", "1abc41b23654f171aff2ce4b449cf99d1709708a436f1b827dbddc6a40ca2cbd"]} 2025-11-10T00:49:27.407Z INFO miner/protocol_block.go:619 update finalized block (debug transaction) {"txn": "1abc41b23654f171aff2ce4b449cf99d1709708a436f1b827dbddc6a40ca2cbd", "block": "a5a02e57890ea331e739756d6aae95ddbc38ad762eea55963a4ad535152dc249"} 2025-11-10T00:49:27.407Z INFO miner/protocol_block.go:619 update finalized block (debug transaction) {"txn": "de0be397e42db64597c3896c729875ec01f5c8573a42231a0e472a5c8a1abe8f", "block": "a5a02e57890ea331e739756d6aae95ddbc38ad762eea55963a4ad535152dc249"} 2025-11-10T00:49:27.407Z INFO miner/protocol_block.go:613 update finalized block {"round": 179692, "block": "a5a02e57890ea331e739756d6aae95ddbc38ad762eea55963a4ad535152dc249", "lf_round": 179691, "current_round": 179696, "weight": 1} 2025-11-10T00:49:27.407Z DEBUG chain/protocol_block.go:409 MPT state node stat - inc {"node num": -342576, "change num": 11, "delete num": 15} 2025-11-10T00:49:27.407Z DEBUG miner/protocol_bls.go:496 VRF Hurray we've threshold BLS shares {"round": 179696, "round pointer": "0xc012a64f30"} 2025-11-10T00:49:27.407Z DEBUG round/entity.go:684 add_vrf_share {"round": 179696, "round_vrf_num": 2, "threshold": 2} 2025-11-10T00:49:27.407Z INFO miner/protocol_bls.go:430 verified vrf {"round": 179696, "node_id": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "share": "1 e690471684c927a2cf26bb86bc901fe95ea5e8d0cd85a36297269b3e794fe83 614ffe2b14d25c5a5f759e0992300a220d78dbe9ad3ad7ba43b1f1120494434", "from": "1c3227e496fdf3c9aa604f3470a2bbd1", "message": "1796960-4330166c9e66e307"} 2025-11-10T00:49:27.406Z INFO block/entity.go:1195 save state {"round": 179692, "block": "a5a02e57890ea331e739756d6aae95ddbc38ad762eea55963a4ad535152dc249", "block_size": 2, "changes": 11, "client_state": "6eb5ce484c6bd27d023c212e12da26da62b40351f4a8e9632461df347e8fd95e", "duration": "1.756875ms"} 2025-11-10T00:49:27.406Z DEBUG util/merkle_patricia_trie.go:272 MPT save changes success {"duration": "1.280249ms"} 2025-11-10T00:49:27.406Z DEBUG util/mpt_node_change.go:156 MPT - update changes done {"changes": 11} 2025-11-10T00:49:27.405Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"vrf_share","value":"VRF Share"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "duration": "1.646674ms"} 2025-11-10T00:49:27.405Z DEBUG bls/dkg.go:396 dkg verify {"id": "1c3227e496fdf3c9aa604f3470a2bbd1", "key": "1 6603e20478fac2c72a61b85056977b92696b8fffd408d8acac0e1f47aed3f96 1501242ed9000d9c6a02764160261164a52360a692c34ed452ff097bc90ee9b3 7f8aaa178d31fa4cbd0c1974768dfa4921e29405754ebf8d2c163a774b741a2 24515e04bd685a5559260f5d1868e5ea11abaf21f55a56aee52c15d9f3c2b053", "msg": "1796960-4330166c9e66e307", "sig": "1 e690471684c927a2cf26bb86bc901fe95ea5e8d0cd85a36297269b3e794fe83 614ffe2b14d25c5a5f759e0992300a220d78dbe9ad3ad7ba43b1f1120494434"} 2025-11-10T00:49:27.405Z INFO miner/protocol_bls.go:489 Not yet reached threshold {"vrfShares_num": 1, "threshold": 2, "round": 179696} 2025-11-10T00:49:27.405Z DEBUG round/entity.go:684 add_vrf_share {"round": 179696, "round_vrf_num": 1, "threshold": 2} 2025-11-10T00:49:27.405Z INFO miner/protocol_bls.go:430 verified vrf {"round": 179696, "node_id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "share": "1 e4f9e50c1511f48be9c892785362c7c3960372001c92b4695d246dd517a834d 2471e4d4638a7a9772ba6d5d01cba5dad726e096f20039cfb86c55bec3790f3d", "from": "18f9a15b9551f8552a19cf4750ef14bf", "message": "1796960-4330166c9e66e307"} 2025-11-10T00:49:27.405Z DEBUG util/mpt_node_change.go:150 MPT - update changes {"changes": 11} 2025-11-10T00:49:27.405Z INFO miner/protocol_bls.go:265 BLS sign VRF share calculated for {"round": 179696, "round_timeout": 0, "prev_rseed": -4841394255193105159, "prev round vrf random seed": "-4330166c9e66e307", "bls_msg": "1796960-4330166c9e66e307"} 2025-11-10T00:49:27.405Z INFO miner/protocol_bls.go:364 DKG AddVRFShare {"round": 179696, "round_vrf_num": 0, "threshold": 2, "sender": 2, "round_timeout_count": 0, "vrf_timeout_count": 0, "vrf_share": "1 e690471684c927a2cf26bb86bc901fe95ea5e8d0cd85a36297269b3e794fe83 614ffe2b14d25c5a5f759e0992300a220d78dbe9ad3ad7ba43b1f1120494434"} 2025-11-10T00:49:27.405Z INFO miner/protocol_round.go:78 add_my_vrf_share {"round": 179696, "round_timeout": 0, "dkg_starting_round": 0, "dkg_mb_number": 1, "pr_seed": -4841394255193105159, "pr_vrf_seed": "-4330166c9e66e307", "share": "1 e690471684c927a2cf26bb86bc901fe95ea5e8d0cd85a36297269b3e794fe83 614ffe2b14d25c5a5f759e0992300a220d78dbe9ad3ad7ba43b1f1120494434"} 2025-11-10T00:49:27.405Z DEBUG miner/protocol_bls.go:305 get_bls_share {"round": 179696, "rtc": 0, "dkg_pi": "1 6603e20478fac2c72a61b85056977b92696b8fffd408d8acac0e1f47aed3f96 1501242ed9000d9c6a02764160261164a52360a692c34ed452ff097bc90ee9b3 7f8aaa178d31fa4cbd0c1974768dfa4921e29405754ebf8d2c163a774b741a2 24515e04bd685a5559260f5d1868e5ea11abaf21f55a56aee52c15d9f3c2b053", "dkg_sr": 0, "mb_sr": 0, "share": "1 e690471684c927a2cf26bb86bc901fe95ea5e8d0cd85a36297269b3e794fe83 614ffe2b14d25c5a5f759e0992300a220d78dbe9ad3ad7ba43b1f1120494434"} 2025-11-10T00:49:27.405Z INFO miner/protocol_receive.go:370 process notarization success {"round": 179695, "block": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db", "duration": "2.517727ms"} 2025-11-10T00:49:27.405Z DEBUG round/entity.go:311 add notarized block - block already exist, merge tickets {"round": 179695, "block": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db"} 2025-11-10T00:49:27.405Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 179695, "randk": 0, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T00:49:27.405Z DEBUG miner/protocol_round.go:1149 check block notarization - block notarized {"round": 179695, "block": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db"} 2025-11-10T00:49:27.405Z DEBUG round/entity.go:311 add notarized block - block already exist, merge tickets {"round": 179695, "block": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db"} 2025-11-10T00:49:27.405Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 179695, "randk": 0, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T00:49:27.405Z INFO round/entity.go:618 get miners by rank {"num_miners": 3, "round": 179692, "r.minerPerm": [2, 1, 0]} 2025-11-10T00:49:27.405Z INFO chain/protocol_block.go:363 finalize block -- round {"round": {"number":179692,"round_random_seed":190180383692214783,"block_hash":"a5a02e57890ea331e739756d6aae95ddbc38ad762eea55963a4ad535152dc249","vrf_output":"02a3a80d2538d1ffe1a4647b6bc8e937f8476ef7bbb430a6ea734e23a5825991"}, "block": "a5a02e57890ea331e739756d6aae95ddbc38ad762eea55963a4ad535152dc249"} 2025-11-10T00:49:27.405Z INFO chain/protocol_block.go:319 reached notarization - merging tickets {"round": 179695, "current_round": 179696, "block": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db", "tickets_num": 3} 2025-11-10T00:49:27.405Z INFO chain/protocol_block.go:328 finalize block {"round": 179692, "current_round": 179696, "lf_round": 179691, "hash": "a5a02e57890ea331e739756d6aae95ddbc38ad762eea55963a4ad535152dc249", "round_rank": 0, "state": 7} 2025-11-10T00:49:27.404Z DEBUG chain/worker.go:262 start to finalize block {"round": 179692, "block": "a5a02e57890ea331e739756d6aae95ddbc38ad762eea55963a4ad535152dc249", "prev block": "4aeda1b8f1ae347af7613307a8774ea7e9d69eb0f4975407648df7e82f98259a"} 2025-11-10T00:49:27.404Z INFO chain/protocol_round.go:359 finalize round {"round": 179692, "lfb round": 179694, "block": "a5a02e57890ea331e739756d6aae95ddbc38ad762eea55963a4ad535152dc249"} 2025-11-10T00:49:27.404Z INFO chain/protocol_round.go:326 finalize round - latest finalized round {"round": 179695, "lfb round": 179694, "lfb block": "871c64a36a39760e08b1e5a33c7daff8c82e789f28f5943382521c786e2239c6"} 2025-11-10T00:49:27.404Z INFO chain/protocol_round.go:199 finalize round {"round": 179695, "plfb_round": 179691, "num_round_notarized": 1, "num_chain_notarized": 3} 2025-11-10T00:49:27.404Z DEBUG bls/dkg.go:356 dkg sign {"key": "21d97039e984194d599f2bf60c03d185c67ff756eba44a56ac9cf108c33c814a", "pi": "1 6603e20478fac2c72a61b85056977b92696b8fffd408d8acac0e1f47aed3f96 1501242ed9000d9c6a02764160261164a52360a692c34ed452ff097bc90ee9b3 7f8aaa178d31fa4cbd0c1974768dfa4921e29405754ebf8d2c163a774b741a2 24515e04bd685a5559260f5d1868e5ea11abaf21f55a56aee52c15d9f3c2b053"} 2025-11-10T00:49:27.404Z DEBUG chain/protocol_round.go:160 finalize round {"round": 179695, "lf_round": 179691} 2025-11-10T00:49:27.404Z DEBUG miner/protocol_bls.go:293 Sign msg with dkg {"msg": "1796960-4330166c9e66e307", "round": 179696, "dkg starting round": 0} 2025-11-10T00:49:27.404Z DEBUG bls/dkg.go:396 dkg verify {"id": "18f9a15b9551f8552a19cf4750ef14bf", "key": "1 15981a99909f8d701bca846be62c295e8958436831d3087ded78a1719a92f9a9 1bc96c0fea12a9ee4451600417977d1e987b252b469ea7c7be9d40e681fceff4 164089f6538d2b42ac3b37af7bc35e2550212af1e8ccedfeec4bde4f472dd384 aa502eaa78fb0cc02bd92538e258b55b1495cdc393205378d4ead83eb106f33", "msg": "1796960-4330166c9e66e307", "sig": "1 e4f9e50c1511f48be9c892785362c7c3960372001c92b4695d246dd517a834d 2471e4d4638a7a9772ba6d5d01cba5dad726e096f20039cfb86c55bec3790f3d"} 2025-11-10T00:49:27.404Z INFO miner/protocol_bls.go:265 BLS sign VRF share calculated for {"round": 179696, "round_timeout": 0, "prev_rseed": -4841394255193105159, "prev round vrf random seed": "-4330166c9e66e307", "bls_msg": "1796960-4330166c9e66e307"} 2025-11-10T00:49:27.404Z INFO miner/protocol_bls.go:283 DKG getBlsShare {"Round Number": 179696} 2025-11-10T00:49:27.404Z INFO miner/protocol_round.go:244 StartNextRound - add VRF {"round": 179696} 2025-11-10T00:49:27.404Z INFO miner/round.go:40 Try to cancel block generation that have not been started yet {"round": 179695} 2025-11-10T00:49:27.404Z DEBUG miner/protocol_round.go:210 finalizedRound - cancel round verification {"round": 179695} 2025-11-10T00:49:27.404Z INFO miner/protocol_bls.go:265 BLS sign VRF share calculated for {"round": 179696, "round_timeout": 0, "prev_rseed": -4841394255193105159, "prev round vrf random seed": "-4330166c9e66e307", "bls_msg": "1796960-4330166c9e66e307"} 2025-11-10T00:49:27.404Z INFO miner/protocol_bls.go:364 DKG AddVRFShare {"round": 179696, "round_vrf_num": 0, "threshold": 2, "sender": 0, "round_timeout_count": 0, "vrf_timeout_count": 0, "vrf_share": "1 e4f9e50c1511f48be9c892785362c7c3960372001c92b4695d246dd517a834d 2471e4d4638a7a9772ba6d5d01cba5dad726e096f20039cfb86c55bec3790f3d"} 2025-11-10T00:49:27.404Z DEBUG miner/protocol_receive.go:26 handle vrf share {"round": 179696, "vrf_timeout_count": 0, "sender_index": 0} 2025-11-10T00:49:27.404Z DEBUG miner/worker.go:53 message {"msg": {"code":"vrf_share","value":"VRF Share"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71"} 2025-11-10T00:49:27.404Z INFO chain/entity.go:2016 Moving to the next round {"next_round": 179696} 2025-11-10T00:49:27.404Z DEBUG miner/protocol_round.go:154 [wait not ahead] [2] not ahead, can move on {"round": 179695, "lfb tk round": 179691} 2025-11-10T00:49:27.404Z DEBUG miner/protocol_round.go:123 [wait not ahead] 2025-11-10T00:49:27.404Z DEBUG miner/protocol_round.go:991 verification_complete {"top_verified_rank": 0} 2025-11-10T00:49:27.404Z INFO miner/protocol_round.go:986 verification_complete {"round": 179695, "verified_blocks": 0} 2025-11-10T00:49:27.404Z DEBUG miner/protocol_round.go:943 verifyAndSend - finished successfully {"round": 179695, "block": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db"} 2025-11-10T00:49:27.404Z INFO miner/round.go:44 Cancelling block generation {"round": 179695} 2025-11-10T00:49:27.403Z INFO miner/round.go:230 Cancelling verification {"round": 179695} 2025-11-10T00:49:27.403Z INFO miner/protocol_receive.go:456 process notarization - start next round {"new round": 179696} 2025-11-10T00:49:27.403Z DEBUG miner/protocol_round.go:1149 check block notarization - block notarized {"round": 179695, "block": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db"} 2025-11-10T00:49:27.403Z DEBUG round/entity.go:344 reached notarization {"round": 179695} 2025-11-10T00:49:27.403Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 179695, "randk": 0, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T00:49:27.403Z INFO chain/entity.go:1571 Adding a notarized block for current round {"Round": 179695} 2025-11-10T00:49:27.403Z INFO chain/protocol_block.go:303 reached notarization - add tickets {"round": 179695, "current_round": 179695, "block": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db", "tickets_num": 2} 2025-11-10T00:49:27.403Z INFO miner/protocol_round.go:920 verifyAndSend - sending verification ticket {"round": 179695, "block": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db", "block_rank": 0, "RRS": -4841394255193105159} 2025-11-10T00:49:27.403Z INFO chain/protocol_block.go:319 reached notarization - merging tickets {"round": 179694, "current_round": 179695, "block": "871c64a36a39760e08b1e5a33c7daff8c82e789f28f5943382521c786e2239c6", "tickets_num": 3} 2025-11-10T00:49:27.403Z DEBUG miner/protocol_round.go:1069 verify round block - finished verification {"block": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db"} 2025-11-10T00:49:27.403Z INFO miner/protocol_block.go:376 verify block successful {"round": 179695, "block_size": 1, "time": "13.441965ms", "block": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db", "prev_block": "871c64a36a39760e08b1e5a33c7daff8c82e789f28f5943382521c786e2239c6", "state_hash": "f48182ce8560cf2333eafc6679725ebb434d57da56b453e9972c6c25fcc684c0", "state_status": 4} 2025-11-10T00:49:27.403Z DEBUG miner/protocol_block.go:374 SignBlock finished {"block": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db", "spent": "218.863µs"} 2025-11-10T00:49:27.403Z DEBUG miner/protocol_receive.go:428 process notarization - merge notarization block {"round": 179695, "block": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db"} 2025-11-10T00:49:27.403Z DEBUG miner/protocol_block.go:367 VerifyBlockMagicBlock finished {"block": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db", "spent": "530ns"} 2025-11-10T00:49:27.403Z DEBUG miner/protocol_block.go:360 verifySmartContracts finished {"block": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db", "spent": "940ns"} 2025-11-10T00:49:27.403Z DEBUG miner/protocol_block.go:351 verify block - ComputeState finished {"round": 179695, "block": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db", "spent": "10.522314ms"} 2025-11-10T00:49:27.403Z INFO block/entity.go:1034 compute state successful {"round": 179695, "block": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db", "block ptr": "0xc01a4952c0", "block_size": 1, "duration": "10.447922ms", "changes": 9, "begin_client_state": "a46f078959be7aec8e2582ca3a5b2ba3afc0f676786c5ffd8be4b02deebe2bd8", "computed_state_hash": "f48182ce8560cf2333eafc6679725ebb434d57da56b453e9972c6c25fcc684c0", "block_state_hash": "f48182ce8560cf2333eafc6679725ebb434d57da56b453e9972c6c25fcc684c0", "prev_block": "871c64a36a39760e08b1e5a33c7daff8c82e789f28f5943382521c786e2239c6", "prev_block_client_state": "a46f078959be7aec8e2582ca3a5b2ba3afc0f676786c5ffd8be4b02deebe2bd8"} 2025-11-10T00:49:27.403Z DEBUG statecache/statecache.go:131 statecache - commit {"block": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db", "bc_hits": 54, "bc_miss": 0, "sc_hits": 16632386, "sc_miss": 4957, "duration": "316.874µs"} 2025-11-10T00:49:27.402Z DEBUG miner/protocol_receive.go:413 Computing state for block we received notarization for 2025-11-10T00:49:27.402Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"notarization","value":"Notarization"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "duration": "62.92µs"} 2025-11-10T00:49:27.402Z DEBUG miner/worker.go:53 message {"msg": {"code":"notarization","value":"Notarization"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71"} 2025-11-10T00:49:27.401Z DEBUG chain/state.go:961 Updating nonce {"client": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "new_nonce": 91625} 2025-11-10T00:49:27.401Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T00:49:27.401Z INFO chain/state.go:533 SC executed {"client id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "block": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db", "round": 179695, "prev_state_hash": "a46f078959be7aec8e2582ca3a5b2ba3afc0f676786c5ffd8be4b02deebe2bd8", "txn_hash": "ab0de3ca0e5ac6afdac561f0fe36d40a5c802f62b12dcb5eccec4a99e88bf481", "txn_nonce": 91625, "txn_func": "payFees", "txn_status": 1, "txn_exec_time": "8.18099ms", "begin client state": "a46f078959be7aec8e2582ca3a5b2ba3afc0f676786c5ffd8be4b02deebe2bd8", "current_root": "0026e8c9c81571769aea56d0a933a5afa2cdbd4ae4cd6e80f2a7ab1f192b5b73", "mpt_cache_hit": 42, "mpt_cache_miss": 0, "output": ""} 2025-11-10T00:49:27.400Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T00:49:27.400Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T00:49:27.400Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T00:49:27.399Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T00:49:27.393Z ERROR minersc/global_node.go:372 failed to get current magic block {"error": "value not present"} 0chain.net/smartcontract/minersc.(*GlobalNode).prevMagicBlock /0chain/code/go/0chain.net/smartcontract/minersc/global_node.go:372 0chain.net/smartcontract/minersc.getRegisterShardersInMagicBlock /0chain/code/go/0chain.net/smartcontract/minersc/fees.go:659 0chain.net/smartcontract/minersc.(*MinerSmartContract).payFees /0chain/code/go/0chain.net/smartcontract/minersc/fees.go:519 0chain.net/smartcontract/minersc.(*MinerSmartContract).Execute /0chain/code/go/0chain.net/smartcontract/minersc/sc.go:139 0chain.net/chaincore/smartcontract.ExecuteWithStats /0chain/code/go/0chain.net/chaincore/smartcontract/handler.go:52 0chain.net/chaincore/smartcontract.ExecuteSmartContract /0chain/code/go/0chain.net/chaincore/smartcontract/handler.go:67 0chain.net/chaincore/chain.(*Chain).ExecuteSmartContract.func1 /0chain/code/go/0chain.net/chaincore/chain/state.go:158 2025-11-10T00:49:27.393Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "6dba10422e368813802877a85039d3985d96760ed844092319743fb3a76712d9d2208fe938b7465b9c5dc571053986cf8dbf3585fb36399f98ea569c42f50b76"} 2025-11-10T00:49:27.393Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "6dba10422e368813802877a85039d3985d96760ed844092319743fb3a76712d9b5e8a1650666fdd3a9de7855b6da63ab629b1701f23738477e2325f7ca2150ac"} 2025-11-10T00:49:27.393Z DEBUG minersc/fees.go:480 pay_fees, got miner id successfully {"miner id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "round": 179695, "block": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db"} 2025-11-10T00:49:27.393Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T00:49:27.393Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T00:49:27.392Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T00:49:27.392Z DEBUG miner/protocol_block.go:339 ValidateBlockCost {"round": 179695, "hash": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db", "calculated cost": 0} 2025-11-10T00:49:27.392Z DEBUG miner/protocol_block.go:305 ValidateTransactions finished {"block": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db", "spent": "1.338289ms"} 2025-11-10T00:49:27.391Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"verification_ticket","value":"Verification Ticket"}, "sender_index": 1, "id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "duration": "1.453651ms"} 2025-11-10T00:49:27.391Z INFO miner/protocol_round.go:1127 checkBlockNotarization -- block is not Notarized. Returning {"round": 179695, "block hash": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db"} 2025-11-10T00:49:27.391Z INFO chain/protocol_block.go:225 not reached notarization {"mb_sr": 0, "active_miners": 3, "threshold": 2, "num_signatures": 1, "current_round": 179695, "round": 179695} 2025-11-10T00:49:27.391Z DEBUG miner/protocol_receive.go:298 handle vt. msg - verify ticket successfully {"round": 179695, "block": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db", "verifier": 1} 2025-11-10T00:49:27.391Z DEBUG miner/protocol_block.go:299 GetPreviousBlock finished {"block": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db", "spent": "1.92µs"} 2025-11-10T00:49:27.391Z DEBUG miner/protocol_block.go:292 VerifyBlockMagicBlockReference finished {"block": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db", "spent": "3.39µs"} 2025-11-10T00:49:27.391Z DEBUG miner/protocol_block.go:286 Validating finished {"block": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db", "spent": "906.733µs"} 2025-11-10T00:49:27.390Z DEBUG miner/protocol_round.go:1067 verify round block - started verification {"block": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db"} 2025-11-10T00:49:27.390Z DEBUG miner/protocol_round.go:1040 verify round block {"round": 179695, "block": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db"} 2025-11-10T00:49:27.390Z DEBUG miner/protocol_round.go:865 verifyAndSend - started {"block": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db"} 2025-11-10T00:49:27.390Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 179695, "randk": 1, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T00:49:27.389Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 179695, "randk": 0, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T00:49:27.389Z DEBUG miner/worker.go:53 message {"msg": {"code":"verification_ticket","value":"Verification Ticket"}, "sender_index": 1, "id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341"} 2025-11-10T00:49:27.389Z INFO miner/protocol_round.go:951 Started main verification loop {"round": 179695} 2025-11-10T00:49:27.388Z DEBUG miner/m_handler.go:365 handle vt. msg - verification ticket {"round": 179695, "block": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db"} 2025-11-10T00:49:27.388Z DEBUG chain/entity.go:440 process block, no block in buffer {"current round": 179695} 2025-11-10T00:49:27.346Z DEBUG chain/protocol_lfb_ticket.go:386 update lfb ticket - ticket.Round <= latest.Round {"ticket.Round": 179691, "latest.Round": 179691} 2025-11-10T00:49:27.336Z DEBUG chain/protocol_lfb_ticket.go:386 update lfb ticket - ticket.Round <= latest.Round {"ticket.Round": 179691, "latest.Round": 179691} 2025-11-10T00:49:27.287Z DEBUG chain/entity.go:440 process block, no block in buffer {"current round": 179695} 2025-11-10T00:49:27.223Z DEBUG miner/protocol_round.go:1028 verify block - pending {"round": 179695, "block": "41c165ccfceeb3b798c70e83813127afb7aca6bd31f9533080510c817edb6cd5"} 2025-11-10T00:49:27.223Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 179695, "randk": 1, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T00:49:27.223Z DEBUG miner/round.go:143 Adding block to verifyChannel {"round": 179695, "block hash": "41c165ccfceeb3b798c70e83813127afb7aca6bd31f9533080510c817edb6cd5", "magic block": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "magic block round": 0} 2025-11-10T00:49:27.223Z INFO miner/protocol_round.go:803 adding block to verify {"round": 179695, "block": "41c165ccfceeb3b798c70e83813127afb7aca6bd31f9533080510c817edb6cd5", "prev_block": "871c64a36a39760e08b1e5a33c7daff8c82e789f28f5943382521c786e2239c6", "state_hash": "0c34d39255ae1a1fd99197c282ec687301c66fc999a604ce8ef2a7477e5ba584", "weight": 0.5} 2025-11-10T00:49:27.223Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 179695, "randk": 1, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T00:49:27.223Z DEBUG statecache/statecache.go:131 statecache - commit {"block": "41c165ccfceeb3b798c70e83813127afb7aca6bd31f9533080510c817edb6cd5", "bc_hits": 57, "bc_miss": 0, "sc_hits": 16632332, "sc_miss": 4957, "duration": "420.306µs"} 2025-11-10T00:49:27.222Z INFO miner/protocol_block.go:1316 generate block (assemble+update+sign) {"round": 179695, "block_size": 1, "reused_txns": 0, "reused_txns": 0, "time": "13.405385ms", "block": "41c165ccfceeb3b798c70e83813127afb7aca6bd31f9533080510c817edb6cd5", "prev_block": "871c64a36a39760e08b1e5a33c7daff8c82e789f28f5943382521c786e2239c6", "begin_state_hash": "a46f078959be7aec8e2582ca3a5b2ba3afc0f676786c5ffd8be4b02deebe2bd8", "block_state_hash": "0c34d39255ae1a1fd99197c282ec687301c66fc999a604ce8ef2a7477e5ba584", "computed_state_hash": "0c34d39255ae1a1fd99197c282ec687301c66fc999a604ce8ef2a7477e5ba584", "changes": 11, "state_status": 4, "iteration_count": 0} 2025-11-10T00:49:27.222Z DEBUG miner/protocol_block.go:1305 generate block (assemble+update) {"round": 179695, "txns": 1, "time": "13.186542ms"} 2025-11-10T00:49:27.222Z DEBUG miner/protocol_block.go:1282 generate block (assemble) {"round": 179695, "txns": 1, "time": "13.129831ms"} 2025-11-10T00:49:27.221Z DEBUG chain/state.go:961 Updating nonce {"client": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "new_nonce": 92493} 2025-11-10T00:49:27.220Z DEBUG miner/protocol_round.go:1028 verify block - pending {"round": 179695, "block": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db"} 2025-11-10T00:49:27.220Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 179695, "randk": 0, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T00:49:27.220Z DEBUG miner/protocol_receive.go:130 verify block processed {"round": 179695, "block": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db"} 2025-11-10T00:49:27.220Z DEBUG miner/round.go:143 Adding block to verifyChannel {"round": 179695, "block hash": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db", "magic block": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "magic block round": 0} 2025-11-10T00:49:27.220Z DEBUG miner/protocol_round.go:759 update prev block notarization, already notarized {"round": 179694, "block": "871c64a36a39760e08b1e5a33c7daff8c82e789f28f5943382521c786e2239c6"} 2025-11-10T00:49:27.220Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T00:49:27.220Z INFO miner/protocol_round.go:803 adding block to verify {"round": 179695, "block": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db", "prev_block": "871c64a36a39760e08b1e5a33c7daff8c82e789f28f5943382521c786e2239c6", "state_hash": "f48182ce8560cf2333eafc6679725ebb434d57da56b453e9972c6c25fcc684c0", "weight": 1} 2025-11-10T00:49:27.220Z INFO miner/protocol_round.go:613 handle verify block - added block for ticket verification {"round": 179695, "block": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db", "magic block": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "magic block round": 0} 2025-11-10T00:49:27.220Z INFO chain/protocol_block.go:225 not reached notarization {"mb_sr": 0, "active_miners": 3, "threshold": 2, "num_signatures": 0, "current_round": 179695, "round": 179695} 2025-11-10T00:49:27.220Z INFO chain/state.go:533 SC executed {"client id": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "block": "", "round": 179695, "prev_state_hash": "a46f078959be7aec8e2582ca3a5b2ba3afc0f676786c5ffd8be4b02deebe2bd8", "txn_hash": "e3286ce72d1ae6743e3b4c56b86861195e8b92143d8091fd922d653ebeee95f6", "txn_nonce": 92493, "txn_func": "payFees", "txn_status": 0, "txn_exec_time": "8.23765ms", "begin client state": "a46f078959be7aec8e2582ca3a5b2ba3afc0f676786c5ffd8be4b02deebe2bd8", "current_root": "c22a2463cc10415c63b1749e7c4847f6e1ba5bb17c7ee8af041e18374e921cfb", "mpt_cache_hit": 44, "mpt_cache_miss": 0, "output": ""} 2025-11-10T00:49:27.219Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T00:49:27.219Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T00:49:27.219Z DEBUG miner/protocol_receive.go:169 verify block {"round": 179695, "block": "0f70dc5da805bb0686613a0030a1337b2158e1eeeed24d97b820efadc473e2db"} 2025-11-10T00:49:27.219Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"verify_block","value":"Verify Block"}, "sender_index": 1, "id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "duration": "48.721µs"} 2025-11-10T00:49:27.219Z DEBUG miner/worker.go:53 message {"msg": {"code":"verify_block","value":"Verify Block"}, "sender_index": 1, "id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341"} 2025-11-10T00:49:27.219Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T00:49:27.218Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T00:49:27.212Z ERROR minersc/global_node.go:372 failed to get current magic block {"error": "value not present"} 0chain.net/smartcontract/minersc.(*GlobalNode).prevMagicBlock /0chain/code/go/0chain.net/smartcontract/minersc/global_node.go:372 0chain.net/smartcontract/minersc.getRegisterShardersInMagicBlock /0chain/code/go/0chain.net/smartcontract/minersc/fees.go:659 0chain.net/smartcontract/minersc.(*MinerSmartContract).payFees /0chain/code/go/0chain.net/smartcontract/minersc/fees.go:519 0chain.net/smartcontract/minersc.(*MinerSmartContract).Execute /0chain/code/go/0chain.net/smartcontract/minersc/sc.go:139 0chain.net/chaincore/smartcontract.ExecuteWithStats /0chain/code/go/0chain.net/chaincore/smartcontract/handler.go:52 0chain.net/chaincore/smartcontract.ExecuteSmartContract /0chain/code/go/0chain.net/chaincore/smartcontract/handler.go:67 0chain.net/chaincore/chain.(*Chain).ExecuteSmartContract.func1 /0chain/code/go/0chain.net/chaincore/chain/state.go:158 2025-11-10T00:49:27.212Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "6dba10422e368813802877a85039d3985d96760ed844092319743fb3a76712d9d2208fe938b7465b9c5dc571053986cf8dbf3585fb36399f98ea569c42f50b76"} 2025-11-10T00:49:27.212Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "6dba10422e368813802877a85039d3985d96760ed844092319743fb3a76712d9b5e8a1650666fdd3a9de7855b6da63ab629b1701f23738477e2325f7ca2150ac"} 2025-11-10T00:49:27.212Z DEBUG minersc/fees.go:480 pay_fees, got miner id successfully {"miner id": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "round": 179695, "block": ""} 2025-11-10T00:49:27.212Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T00:49:27.212Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T00:49:27.211Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T00:49:27.211Z DEBUG chain/protocol_view_change.go:424 [mvc] nonce, set nonce in getCurrentSelfNonce {"nonce": 92492} 2025-11-10T00:49:27.211Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "%\ufffd\u0012\ufffd\ufffd\ufffd\ufffd\ufffd\ufffd\ufffd\u000f\ufffd\ufffd;I\\\ufffd\u0013\ufffdQr/b\ufffd\r\ufffd\ufffd+N!\ufffd\u0016"} 2025-11-10T00:49:27.211Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\u0014\u001do\u001b6-]x!3\ufffdfvv\ufffd\ufffdu\ufffda\ufffd8PXt\ufffd\rn\u0012ȥ\ufffd\ufffd"} 2025-11-10T00:49:27.211Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\ufffd_[\ufffd\ufffd\ufffd\ufffd=\ufffd\ufffd\ufffdZ\ufffd\ufffda\ufffd\ufffd\ufffd\ufffd\ufffd\u0016Wxa\ufffd\ufffd\ufffdu0\ufffd#*"} 2025-11-10T00:49:27.211Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\ufffd\ufffdv\ufffd\ufffdl\ufffdr\ufffd\ufffd\ufffdF\ufffd+\ufffd\u0017H{~\ufffd\ufffd\ufffdi\ufffdO\ufffd\u0000\ufffd\ufffd\ufffd\ufffd\ufffd"} 2025-11-10T00:49:27.211Z INFO chain/entity.go:1721 delete blocks below round {"round": 179695, "below_round": 179641, "before": 1762735707, "total": 313, "count": 5} 2025-11-10T00:49:27.210Z DEBUG chain/entity.go:1714 found block to delete {"round": 179641, "block_round": 179396, "current_round": 179695, "lf_round": 179691} 2025-11-10T00:49:27.210Z DEBUG chain/entity.go:1714 found block to delete {"round": 179641, "block_round": 179399, "current_round": 179695, "lf_round": 179691} 2025-11-10T00:49:27.210Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "<\ufffd>\ufffds\ufffd)z\ufffd\ufffd%|F\ufffd\u001a\ufffd3k\u00119\u0013\ufffdf\ufffd\ufffd\ufffd\ufffdݬ)\u0010u"} 2025-11-10T00:49:27.210Z DEBUG chain/entity.go:1714 found block to delete {"round": 179641, "block_round": 179397, "current_round": 179695, "lf_round": 179691} 2025-11-10T00:49:27.210Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\ufffdo\u0007\ufffdY\ufffdz\ufffd\ufffd%\ufffd\ufffd:[+\ufffd\ufffd\ufffd\ufffdvxl_\ufffd\ufffd\ufffd\ufffd-\ufffd\ufffd+\ufffd"} 2025-11-10T00:49:27.210Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T00:49:27.210Z DEBUG chain/entity.go:1714 found block to delete {"round": 179641, "block_round": 179395, "current_round": 179695, "lf_round": 179691} 2025-11-10T00:49:27.210Z DEBUG chain/protocol_view_change.go:431 [mvc] nonce, get current miner nonce {"minerId": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea"} 2025-11-10T00:49:27.210Z DEBUG chain/entity.go:1714 found block to delete {"round": 179641, "block_round": 179398, "current_round": 179695, "lf_round": 179691} 2025-11-10T00:49:27.210Z INFO memorystore/collection.go:65 Redis returned 0 rows after seclect 2025-11-10T00:49:27.210Z DEBUG chain/protocol_round.go:334 finalize round - block has less than 3 confirmation 2025-11-10T00:49:27.210Z DEBUG chain/protocol_round.go:334 finalize round - block has less than 3 confirmation 2025-11-10T00:49:27.210Z INFO chain/protocol_round.go:402 finalize round - finalize block success {"round": 179691, "block": "4aeda1b8f1ae347af7613307a8774ea7e9d69eb0f4975407648df7e82f98259a", "duration": "4.0887ms"} 2025-11-10T00:49:27.210Z DEBUG chain/worker.go:230 finalize block processed {"round": 179691, "duration": "4.043149ms"} 2025-11-10T00:49:27.210Z DEBUG chain/protocol_block.go:612 finalized block - done {"round": 179691, "block": "4aeda1b8f1ae347af7613307a8774ea7e9d69eb0f4975407648df7e82f98259a", "duration": "3.938477ms"} 2025-11-10T00:49:27.210Z INFO chain/entity.go:2366 config has been updated successfully {"start of round": 179691} 2025-11-10T00:49:27.210Z INFO miner/protocol_block.go:1112 generate block starting iteration {"round": 179695, "prev_block": "871c64a36a39760e08b1e5a33c7daff8c82e789f28f5943382521c786e2239c6", "prev_state_hash": "a46f078959be7aec8e2582ca3a5b2ba3afc0f676786c5ffd8be4b02deebe2bd8"} 2025-11-10T00:49:27.210Z 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-10T00:49:27.210Z DEBUG statecache/statecache.go:173 state cache - see gap {"block": "0a1d0709e7b36484236f49ba15512201289834420ea9115ff09c91df3763330c"} 2025-11-10T00:49:27.210Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\ufffd-<1n\ufffd\ufffdD\ufffd\ufffdå\ufffd\u0017\ufffd\t\ufffd\u001eE\ufffd]\ufffd\ufffd\u0001\ufffd\ufffdƈ;\ufffdx"} 2025-11-10T00:49:27.209Z DEBUG statecache/statecache.go:173 state cache - see gap {"block": "0a1d0709e7b36484236f49ba15512201289834420ea9115ff09c91df3763330c"} 2025-11-10T00:49:27.209Z DEBUG transaction/worker.go:253 [mvc] see no old txns {"clientID": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "nonce": 92488} 2025-11-10T00:49:27.209Z INFO memorystore/collection.go:65 Redis returned 0 rows after seclect 2025-11-10T00:49:27.209Z DEBUG chain/lfb_round_node.go:33 [mvc] store lfb {"round": 179691, "block": "4aeda1b8f1ae347af7613307a8774ea7e9d69eb0f4975407648df7e82f98259a", "mb number": 1} 2025-11-10T00:49:27.209Z DEBUG statecache/statecache.go:173 state cache - see gap {"block": "0a1d0709e7b36484236f49ba15512201289834420ea9115ff09c91df3763330c"} 2025-11-10T00:49:27.209Z DEBUG transaction/worker.go:221 [mvc] remove old nonce txns {"clientID": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "nonce": 92488} 2025-11-10T00:49:27.209Z DEBUG chain/worker.go:443 BC is moving {"current_lfb_round": 179691, "last_round": 179690} 2025-11-10T00:49:27.209Z DEBUG chain/entity.go:2269 set lfb {"round": 179691, "block": "4aeda1b8f1ae347af7613307a8774ea7e9d69eb0f4975407648df7e82f98259a", "state_computed": true} 2025-11-10T00:49:27.209Z DEBUG chain/state.go:128 finalize round - rebased current state db {"round": 179691, "block": "4aeda1b8f1ae347af7613307a8774ea7e9d69eb0f4975407648df7e82f98259a", "state hash": "11926fa10ca6329d39d63b428396bc03380d9ee309f541d8c1e862137638b396"} 2025-11-10T00:49:27.209Z DEBUG util/mpt_nodedb.go:556 LevelNodeDB rebase db 2025-11-10T00:49:27.209Z INFO transaction/worker.go:164 cleaning transactions {"collection": "collection.txn:0afc093ffb509f059c55478bc1a60351cef7b4e9c008a53a6cc8241ca8617dfe", "missing_count": 1, "txns": ["42b55385d1de44774cde28b0bac0d56ea02f4c2ef17f898ef2a5efa95f1d0639"], "past txns": []} 2025-11-10T00:49:27.209Z INFO memorystore/collection.go:65 Redis returned 0 rows after seclect 2025-11-10T00:49:27.209Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 179695, "randk": 1, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T00:49:27.209Z DEBUG miner/protocol_round.go:467 Setting LFMB round/hash for a block {"rn": 179695, "mc.crn": 179695, "rnoff": 179670, "nvc": 0, "r": 0, "h": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "b.lfmbr": 0, "b.lfmbh": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4"} 2025-11-10T00:49:27.208Z DEBUG chain/protocol_block.go:424 finalize block - record dead nodes {"round": 179691, "block": "4aeda1b8f1ae347af7613307a8774ea7e9d69eb0f4975407648df7e82f98259a", "num dead nodes": 11} 2025-11-10T00:49:27.209Z INFO miner/protocol_bls.go:481 DKG ThresholdNumSigReceived VRF is already completed. {"round": 179695} 2025-11-10T00:49:27.208Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"vrf_share","value":"VRF Share"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "duration": "3.047615ms"} 2025-11-10T00:49:27.209Z DEBUG transaction/worker.go:124 cleaning past transactions 2025-11-10T00:49:27.209Z INFO round/entity.go:675 add_vrf_share already at threshold. Returning false. 2025-11-10T00:49:27.208Z INFO miner/protocol_bls.go:430 verified vrf {"round": 179695, "node_id": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "share": "1 6573693cbbfff09d008b23b3384c7eb5cb77d29409a6686cd277f1d803f635e 14460c576952a1f9c9deb5ebcd05a53a235838e6ea66691c9ce1cad96d20658e", "from": "1c3227e496fdf3c9aa604f3470a2bbd1", "message": "1796950-3fe6e93ecb5d354a"} 2025-11-10T00:49:27.208Z DEBUG miner/round.go:238 Round clear - cancel verification 2025-11-10T00:49:27.208Z INFO miner/protocol_round.go:830 Starting round verification {"round": 179695, "delta": "180ms"} 2025-11-10T00:49:27.208Z INFO round/entity.go:618 get miners by rank {"num_miners": 3, "round": 179695, "r.minerPerm": [2, 0, 1]} 2025-11-10T00:49:27.208Z INFO miner/protocol_round.go:340 *** TOC_FIX starting round block generation *** {"round": 179695, "index": 2, "rank": 1, "timeout_count": 0, "random_seed": -4841394255193105159, "lf_round": 179690} 2025-11-10T00:49:27.208Z INFO miner/protocol_bls.go:591 Starting round with vrf {"round": 179695, "roundtimeout": 0, "rseed": -4841394255193105159, "prev_round": 179694, "Prev_rseed": 0} 2025-11-10T00:49:27.208Z DEBUG miner/protocol_bls.go:542 DKG computeRBO {"round": 179695} 2025-11-10T00:49:27.208Z DEBUG miner/chain.go:313 delete txns {"txns": ["42b55385d1de44774cde28b0bac0d56ea02f4c2ef17f898ef2a5efa95f1d0639"]} 2025-11-10T00:49:27.208Z INFO miner/protocol_block.go:619 update finalized block (debug transaction) {"txn": "42b55385d1de44774cde28b0bac0d56ea02f4c2ef17f898ef2a5efa95f1d0639", "block": "4aeda1b8f1ae347af7613307a8774ea7e9d69eb0f4975407648df7e82f98259a"} 2025-11-10T00:49:27.208Z INFO miner/protocol_bls.go:524 receive bls sign {"round": 179695, "group_signature": "1 5c2eff29a6f5ddc6c0f01057d9d51a19ca328c2dfa8cf5d67d94bcc499b7025 1bed7738b7096aeeb689492478077b615bc8731dfdd045f20aacc505309bb3cb", "rboOutput": "bccfe99361991cf998fb7eda965fc0e6cf5fd8e9948acba7db95a86a32f2bc29", "dkg_starting_round": 0, "dkg_mb_number": 1} 2025-11-10T00:49:27.208Z INFO miner/protocol_block.go:613 update finalized block {"round": 179691, "block": "4aeda1b8f1ae347af7613307a8774ea7e9d69eb0f4975407648df7e82f98259a", "lf_round": 179690, "current_round": 179695, "weight": 1} 2025-11-10T00:49:27.208Z DEBUG chain/protocol_block.go:409 MPT state node stat - inc {"node num": -342587, "change num": 11, "delete num": 11} 2025-11-10T00:49:27.208Z INFO block/entity.go:1195 save state {"round": 179691, "block": "4aeda1b8f1ae347af7613307a8774ea7e9d69eb0f4975407648df7e82f98259a", "block_size": 1, "changes": 11, "client_state": "11926fa10ca6329d39d63b428396bc03380d9ee309f541d8c1e862137638b396", "duration": "1.481441ms"} 2025-11-10T00:49:27.208Z DEBUG bls/dkg.go:396 dkg verify {"id": "1c3227e496fdf3c9aa604f3470a2bbd1", "key": "1 6603e20478fac2c72a61b85056977b92696b8fffd408d8acac0e1f47aed3f96 1501242ed9000d9c6a02764160261164a52360a692c34ed452ff097bc90ee9b3 7f8aaa178d31fa4cbd0c1974768dfa4921e29405754ebf8d2c163a774b741a2 24515e04bd685a5559260f5d1868e5ea11abaf21f55a56aee52c15d9f3c2b053", "msg": "1796950-3fe6e93ecb5d354a", "sig": "1 6573693cbbfff09d008b23b3384c7eb5cb77d29409a6686cd277f1d803f635e 14460c576952a1f9c9deb5ebcd05a53a235838e6ea66691c9ce1cad96d20658e"} 2025-11-10T00:49:27.208Z DEBUG miner/protocol_bls.go:496 VRF Hurray we've threshold BLS shares {"round": 179695, "round pointer": "0xc0166f4c60"} 2025-11-10T00:49:27.208Z DEBUG round/entity.go:684 add_vrf_share {"round": 179695, "round_vrf_num": 2, "threshold": 2} 2025-11-10T00:49:27.208Z INFO miner/protocol_bls.go:430 verified vrf {"round": 179695, "node_id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "share": "1 17aa2bd18dfdb8ba0ee6faf34f60815ab5d780cc191eea0c164a5c0ddfd07b1d 1da4fcecc9a67a617dc1c5042f19f6231c5b9c7bc863b8335bf2c94c203b3ebe", "from": "18f9a15b9551f8552a19cf4750ef14bf", "message": "1796950-3fe6e93ecb5d354a"} 2025-11-10T00:49:27.208Z INFO memorystore/collection.go:65 Redis returned 0 rows after seclect 2025-11-10T00:49:27.207Z DEBUG util/merkle_patricia_trie.go:272 MPT save changes success {"duration": "999.474µs"} 2025-11-10T00:49:27.207Z DEBUG util/mpt_node_change.go:156 MPT - update changes done {"changes": 11} 2025-11-10T00:49:27.207Z DEBUG bls/dkg.go:396 dkg verify {"id": "18f9a15b9551f8552a19cf4750ef14bf", "key": "1 15981a99909f8d701bca846be62c295e8958436831d3087ded78a1719a92f9a9 1bc96c0fea12a9ee4451600417977d1e987b252b469ea7c7be9d40e681fceff4 164089f6538d2b42ac3b37af7bc35e2550212af1e8ccedfeec4bde4f472dd384 aa502eaa78fb0cc02bd92538e258b55b1495cdc393205378d4ead83eb106f33", "msg": "1796950-3fe6e93ecb5d354a", "sig": "1 17aa2bd18dfdb8ba0ee6faf34f60815ab5d780cc191eea0c164a5c0ddfd07b1d 1da4fcecc9a67a617dc1c5042f19f6231c5b9c7bc863b8335bf2c94c203b3ebe"} 2025-11-10T00:49:27.207Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"vrf_share","value":"VRF Share"}, "sender_index": 0, "id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "duration": "1.668085ms"} 2025-11-10T00:49:27.207Z INFO miner/protocol_bls.go:489 Not yet reached threshold {"vrfShares_num": 1, "threshold": 2, "round": 179695} 2025-11-10T00:49:27.207Z DEBUG round/entity.go:684 add_vrf_share {"round": 179695, "round_vrf_num": 1, "threshold": 2} 2025-11-10T00:49:27.207Z INFO miner/protocol_bls.go:430 verified vrf {"round": 179695, "node_id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "share": "1 dba12acc1486f34e5eff76fc5172f2f8251b73c5b56faa0623618595b53cbe2 6c34f72d29051ee447f3ddade033a7cf274669b3fb05766626cab09f38d61e0", "from": "196b96df7631e00d339f9a25131927c4", "message": "1796950-3fe6e93ecb5d354a"} 2025-11-10T00:49:27.207Z DEBUG util/mpt_node_change.go:150 MPT - update changes {"changes": 11} 2025-11-10T00:49:27.206Z INFO miner/protocol_bls.go:265 BLS sign VRF share calculated for {"round": 179695, "round_timeout": 0, "prev_rseed": -4604624124942038346, "prev round vrf random seed": "-3fe6e93ecb5d354a", "bls_msg": "1796950-3fe6e93ecb5d354a"} 2025-11-10T00:49:27.206Z INFO miner/protocol_bls.go:364 DKG AddVRFShare {"round": 179695, "round_vrf_num": 0, "threshold": 2, "sender": 2, "round_timeout_count": 0, "vrf_timeout_count": 0, "vrf_share": "1 6573693cbbfff09d008b23b3384c7eb5cb77d29409a6686cd277f1d803f635e 14460c576952a1f9c9deb5ebcd05a53a235838e6ea66691c9ce1cad96d20658e"} 2025-11-10T00:49:27.206Z INFO miner/protocol_round.go:78 add_my_vrf_share {"round": 179695, "round_timeout": 0, "dkg_starting_round": 0, "dkg_mb_number": 1, "pr_seed": -4604624124942038346, "pr_vrf_seed": "-3fe6e93ecb5d354a", "share": "1 6573693cbbfff09d008b23b3384c7eb5cb77d29409a6686cd277f1d803f635e 14460c576952a1f9c9deb5ebcd05a53a235838e6ea66691c9ce1cad96d20658e"} 2025-11-10T00:49:27.206Z DEBUG miner/protocol_bls.go:305 get_bls_share {"round": 179695, "rtc": 0, "dkg_pi": "1 6603e20478fac2c72a61b85056977b92696b8fffd408d8acac0e1f47aed3f96 1501242ed9000d9c6a02764160261164a52360a692c34ed452ff097bc90ee9b3 7f8aaa178d31fa4cbd0c1974768dfa4921e29405754ebf8d2c163a774b741a2 24515e04bd685a5559260f5d1868e5ea11abaf21f55a56aee52c15d9f3c2b053", "dkg_sr": 0, "mb_sr": 0, "share": "1 6573693cbbfff09d008b23b3384c7eb5cb77d29409a6686cd277f1d803f635e 14460c576952a1f9c9deb5ebcd05a53a235838e6ea66691c9ce1cad96d20658e"} 2025-11-10T00:49:27.206Z INFO round/entity.go:618 get miners by rank {"num_miners": 3, "round": 179691, "r.minerPerm": [1, 2, 0]} 2025-11-10T00:49:27.206Z INFO chain/protocol_block.go:363 finalize block -- round {"round": {"number":179691,"round_random_seed":3225576468098265172,"block_hash":"4aeda1b8f1ae347af7613307a8774ea7e9d69eb0f4975407648df7e82f98259a","vrf_output":"2cc38cb538db30547b681f45fc458260d1681489f31ce867ca2071f90945a4ab"}, "block": "4aeda1b8f1ae347af7613307a8774ea7e9d69eb0f4975407648df7e82f98259a"} 2025-11-10T00:49:27.206Z INFO chain/protocol_block.go:328 finalize block {"round": 179691, "current_round": 179695, "lf_round": 179690, "hash": "4aeda1b8f1ae347af7613307a8774ea7e9d69eb0f4975407648df7e82f98259a", "round_rank": 0, "state": 7} 2025-11-10T00:49:27.206Z DEBUG chain/worker.go:262 start to finalize block {"round": 179691, "block": "4aeda1b8f1ae347af7613307a8774ea7e9d69eb0f4975407648df7e82f98259a", "prev block": "8d6cac0fd1ce90db18ab77301e37732be643cbe64cb0f5503b9eca9060026bd4"} 2025-11-10T00:49:27.206Z INFO chain/protocol_round.go:359 finalize round {"round": 179691, "lfb round": 179693, "block": "4aeda1b8f1ae347af7613307a8774ea7e9d69eb0f4975407648df7e82f98259a"} 2025-11-10T00:49:27.206Z DEBUG bls/dkg.go:396 dkg verify {"id": "196b96df7631e00d339f9a25131927c4", "key": "1 1f8c72cc3a6b74f6ad7528172b64afe3dc42ee1987495659fe2cf34e749caa7c 20957b4d25e7b5fb1e32d4e3b93e2b73dad7f118efb6dae28715e4ad627b0fff 14259a6ddf4b44c83c1389bd8ed1fc47c1b099c5986bb33923bbcbb25d30054a 2100bb7434dadde1a5ed8545748d0958955bcd21e06cf170f78dbda35a9e04b7", "msg": "1796950-3fe6e93ecb5d354a", "sig": "1 dba12acc1486f34e5eff76fc5172f2f8251b73c5b56faa0623618595b53cbe2 6c34f72d29051ee447f3ddade033a7cf274669b3fb05766626cab09f38d61e0"} 2025-11-10T00:49:27.206Z INFO chain/protocol_round.go:326 finalize round - latest finalized round {"round": 179694, "lfb round": 179693, "lfb block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681"} 2025-11-10T00:49:27.206Z INFO miner/protocol_bls.go:265 BLS sign VRF share calculated for {"round": 179695, "round_timeout": 0, "prev_rseed": -4604624124942038346, "prev round vrf random seed": "-3fe6e93ecb5d354a", "bls_msg": "1796950-3fe6e93ecb5d354a"} 2025-11-10T00:49:27.206Z INFO chain/protocol_round.go:199 finalize round {"round": 179694, "plfb_round": 179690, "num_round_notarized": 1, "num_chain_notarized": 3} 2025-11-10T00:49:27.206Z INFO miner/protocol_bls.go:364 DKG AddVRFShare {"round": 179695, "round_vrf_num": 0, "threshold": 2, "sender": 0, "round_timeout_count": 0, "vrf_timeout_count": 0, "vrf_share": "1 17aa2bd18dfdb8ba0ee6faf34f60815ab5d780cc191eea0c164a5c0ddfd07b1d 1da4fcecc9a67a617dc1c5042f19f6231c5b9c7bc863b8335bf2c94c203b3ebe"} 2025-11-10T00:49:27.206Z INFO miner/protocol_receive.go:370 process notarization success {"round": 179694, "block": "871c64a36a39760e08b1e5a33c7daff8c82e789f28f5943382521c786e2239c6", "duration": "1.857437ms"} 2025-11-10T00:49:27.206Z DEBUG bls/dkg.go:356 dkg sign {"key": "21d97039e984194d599f2bf60c03d185c67ff756eba44a56ac9cf108c33c814a", "pi": "1 6603e20478fac2c72a61b85056977b92696b8fffd408d8acac0e1f47aed3f96 1501242ed9000d9c6a02764160261164a52360a692c34ed452ff097bc90ee9b3 7f8aaa178d31fa4cbd0c1974768dfa4921e29405754ebf8d2c163a774b741a2 24515e04bd685a5559260f5d1868e5ea11abaf21f55a56aee52c15d9f3c2b053"} 2025-11-10T00:49:27.206Z DEBUG chain/protocol_round.go:160 finalize round {"round": 179694, "lf_round": 179690} 2025-11-10T00:49:27.206Z DEBUG miner/protocol_bls.go:293 Sign msg with dkg {"msg": "1796950-3fe6e93ecb5d354a", "round": 179695, "dkg starting round": 0} 2025-11-10T00:49:27.206Z INFO miner/protocol_bls.go:265 BLS sign VRF share calculated for {"round": 179695, "round_timeout": 0, "prev_rseed": -4604624124942038346, "prev round vrf random seed": "-3fe6e93ecb5d354a", "bls_msg": "1796950-3fe6e93ecb5d354a"} 2025-11-10T00:49:27.206Z INFO miner/protocol_bls.go:265 BLS sign VRF share calculated for {"round": 179695, "round_timeout": 0, "prev_rseed": -4604624124942038346, "prev round vrf random seed": "-3fe6e93ecb5d354a", "bls_msg": "1796950-3fe6e93ecb5d354a"} 2025-11-10T00:49:27.206Z INFO miner/protocol_bls.go:364 DKG AddVRFShare {"round": 179695, "round_vrf_num": 0, "threshold": 2, "sender": 0, "round_timeout_count": 0, "vrf_timeout_count": 0, "vrf_share": "1 dba12acc1486f34e5eff76fc5172f2f8251b73c5b56faa0623618595b53cbe2 6c34f72d29051ee447f3ddade033a7cf274669b3fb05766626cab09f38d61e0"} 2025-11-10T00:49:27.206Z INFO miner/protocol_bls.go:283 DKG getBlsShare {"Round Number": 179695} 2025-11-10T00:49:27.206Z INFO miner/protocol_round.go:244 StartNextRound - add VRF {"round": 179695} 2025-11-10T00:49:27.206Z DEBUG miner/protocol_receive.go:26 handle vrf share {"round": 179695, "vrf_timeout_count": 0, "sender_index": 0} 2025-11-10T00:49:27.206Z INFO miner/round.go:40 Try to cancel block generation that have not been started yet {"round": 179694} 2025-11-10T00:49:27.206Z DEBUG miner/protocol_round.go:210 finalizedRound - cancel round verification {"round": 179694} 2025-11-10T00:49:27.205Z INFO chain/entity.go:2016 Moving to the next round {"next_round": 179695} 2025-11-10T00:49:27.205Z DEBUG miner/worker.go:53 message {"msg": {"code":"vrf_share","value":"VRF Share"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71"} 2025-11-10T00:49:27.206Z DEBUG round/entity.go:311 add notarized block - block already exist, merge tickets {"round": 179694, "block": "871c64a36a39760e08b1e5a33c7daff8c82e789f28f5943382521c786e2239c6"} 2025-11-10T00:49:27.205Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 179694, "randk": 0, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T00:49:27.205Z DEBUG miner/protocol_receive.go:26 handle vrf share {"round": 179695, "vrf_timeout_count": 0, "sender_index": 0} 2025-11-10T00:49:27.205Z DEBUG miner/protocol_round.go:154 [wait not ahead] [2] not ahead, can move on {"round": 179694, "lfb tk round": 179690} 2025-11-10T00:49:27.205Z INFO chain/entity.go:1571 Adding a notarized block for current round {"Round": 179694} 2025-11-10T00:49:27.205Z DEBUG miner/protocol_round.go:991 verification_complete {"top_verified_rank": 0} 2025-11-10T00:49:27.205Z INFO miner/protocol_round.go:986 verification_complete {"round": 179694, "verified_blocks": 0} 2025-11-10T00:49:27.205Z DEBUG miner/protocol_round.go:123 [wait not ahead] 2025-11-10T00:49:27.205Z INFO miner/round.go:44 Cancelling block generation {"round": 179694} 2025-11-10T00:49:27.205Z INFO miner/round.go:230 Cancelling verification {"round": 179694} 2025-11-10T00:49:27.205Z INFO miner/protocol_receive.go:456 process notarization - start next round {"new round": 179695} 2025-11-10T00:49:27.205Z DEBUG miner/worker.go:53 message {"msg": {"code":"vrf_share","value":"VRF Share"}, "sender_index": 0, "id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341"} 2025-11-10T00:49:27.205Z DEBUG miner/protocol_round.go:1149 check block notarization - block notarized {"round": 179694, "block": "871c64a36a39760e08b1e5a33c7daff8c82e789f28f5943382521c786e2239c6"} 2025-11-10T00:49:27.205Z DEBUG round/entity.go:344 reached notarization {"round": 179694} 2025-11-10T00:49:27.205Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 179694, "randk": 0, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T00:49:27.205Z INFO chain/entity.go:1571 Adding a notarized block for current round {"Round": 179694} 2025-11-10T00:49:27.205Z INFO chain/protocol_block.go:319 reached notarization - merging tickets {"round": 179694, "current_round": 179694, "block": "871c64a36a39760e08b1e5a33c7daff8c82e789f28f5943382521c786e2239c6", "tickets_num": 2} 2025-11-10T00:49:27.204Z DEBUG miner/protocol_receive.go:428 process notarization - merge notarization block {"round": 179694, "block": "871c64a36a39760e08b1e5a33c7daff8c82e789f28f5943382521c786e2239c6"} 2025-11-10T00:49:27.204Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"notarization","value":"Notarization"}, "sender_index": 0, "id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "duration": "45.44µs"} 2025-11-10T00:49:27.204Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"notarization","value":"Notarization"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "duration": "74.421µs"} 2025-11-10T00:49:27.204Z DEBUG miner/worker.go:53 message {"msg": {"code":"notarization","value":"Notarization"}, "sender_index": 0, "id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341"} 2025-11-10T00:49:27.204Z DEBUG miner/worker.go:53 message {"msg": {"code":"notarization","value":"Notarization"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71"} 2025-11-10T00:49:27.187Z DEBUG chain/entity.go:440 process block, no block in buffer {"current round": 179694} 2025-11-10T00:49:27.185Z DEBUG miner/protocol_round.go:943 verifyAndSend - finished successfully {"round": 179694, "block": "871c64a36a39760e08b1e5a33c7daff8c82e789f28f5943382521c786e2239c6"} 2025-11-10T00:49:27.185Z INFO miner/protocol_round.go:1127 checkBlockNotarization -- block is not Notarized. Returning {"round": 179694, "block hash": "871c64a36a39760e08b1e5a33c7daff8c82e789f28f5943382521c786e2239c6"} 2025-11-10T00:49:27.185Z INFO chain/protocol_block.go:225 not reached notarization {"mb_sr": 0, "active_miners": 3, "threshold": 2, "num_signatures": 1, "current_round": 179694, "round": 179694} 2025-11-10T00:49:27.185Z INFO miner/protocol_round.go:920 verifyAndSend - sending verification ticket {"round": 179694, "block": "871c64a36a39760e08b1e5a33c7daff8c82e789f28f5943382521c786e2239c6", "block_rank": 0, "RRS": -4604624124942038346} 2025-11-10T00:49:27.185Z DEBUG miner/protocol_round.go:1040 verify round block {"round": 179694, "block": "871c64a36a39760e08b1e5a33c7daff8c82e789f28f5943382521c786e2239c6"} 2025-11-10T00:49:27.185Z DEBUG miner/protocol_round.go:865 verifyAndSend - started {"block": "871c64a36a39760e08b1e5a33c7daff8c82e789f28f5943382521c786e2239c6"} 2025-11-10T00:49:27.185Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 179694, "randk": 1, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T00:49:27.185Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 179694, "randk": 0, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T00:49:27.185Z INFO miner/protocol_round.go:951 Started main verification loop {"round": 179694} 2025-11-10T00:49:27.109Z DEBUG chain/protocol_lfb_ticket.go:386 update lfb ticket - ticket.Round <= latest.Round {"ticket.Round": 179690, "latest.Round": 179690} 2025-11-10T00:49:27.102Z DEBUG chain/protocol_lfb_ticket.go:386 update lfb ticket - ticket.Round <= latest.Round {"ticket.Round": 179690, "latest.Round": 179690} 2025-11-10T00:49:27.087Z DEBUG chain/entity.go:440 process block, no block in buffer {"current round": 179694} 2025-11-10T00:49:27.022Z DEBUG miner/protocol_round.go:1028 verify block - pending {"round": 179694, "block": "6c10c0f67800770118e6abe55575ff8f144fb9e6066e0f1e399c4f81a857f28b"} 2025-11-10T00:49:27.022Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 179694, "randk": 1, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T00:49:27.022Z DEBUG miner/protocol_receive.go:130 verify block processed {"round": 179694, "block": "6c10c0f67800770118e6abe55575ff8f144fb9e6066e0f1e399c4f81a857f28b"} 2025-11-10T00:49:27.022Z DEBUG miner/round.go:143 Adding block to verifyChannel {"round": 179694, "block hash": "6c10c0f67800770118e6abe55575ff8f144fb9e6066e0f1e399c4f81a857f28b", "magic block": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "magic block round": 0} 2025-11-10T00:49:27.021Z INFO miner/protocol_round.go:803 adding block to verify {"round": 179694, "block": "6c10c0f67800770118e6abe55575ff8f144fb9e6066e0f1e399c4f81a857f28b", "prev_block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681", "state_hash": "f13e221f2866d581434f1d4589e3d31a42500a215d9bce27cb42c52f58c22ad0", "weight": 1} 2025-11-10T00:49:27.021Z DEBUG miner/protocol_round.go:759 update prev block notarization, already notarized {"round": 179693, "block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681"} 2025-11-10T00:49:27.021Z INFO miner/protocol_round.go:613 handle verify block - added block for ticket verification {"round": 179694, "block": "6c10c0f67800770118e6abe55575ff8f144fb9e6066e0f1e399c4f81a857f28b", "magic block": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "magic block round": 0} 2025-11-10T00:49:27.021Z INFO chain/protocol_block.go:225 not reached notarization {"mb_sr": 0, "active_miners": 3, "threshold": 2, "num_signatures": 0, "current_round": 179694, "round": 179694} 2025-11-10T00:49:27.021Z DEBUG miner/protocol_round.go:1028 verify block - pending {"round": 179694, "block": "871c64a36a39760e08b1e5a33c7daff8c82e789f28f5943382521c786e2239c6"} 2025-11-10T00:49:27.021Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 179694, "randk": 0, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T00:49:27.020Z DEBUG miner/round.go:143 Adding block to verifyChannel {"round": 179694, "block hash": "871c64a36a39760e08b1e5a33c7daff8c82e789f28f5943382521c786e2239c6", "magic block": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "magic block round": 0} 2025-11-10T00:49:27.020Z INFO miner/protocol_round.go:803 adding block to verify {"round": 179694, "block": "871c64a36a39760e08b1e5a33c7daff8c82e789f28f5943382521c786e2239c6", "prev_block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681", "state_hash": "a46f078959be7aec8e2582ca3a5b2ba3afc0f676786c5ffd8be4b02deebe2bd8", "weight": 1} 2025-11-10T00:49:27.020Z DEBUG miner/protocol_receive.go:169 verify block {"round": 179694, "block": "6c10c0f67800770118e6abe55575ff8f144fb9e6066e0f1e399c4f81a857f28b"} 2025-11-10T00:49:27.020Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 179694, "randk": 0, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T00:49:27.020Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"verify_block","value":"Verify Block"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "duration": "58.181µs"} 2025-11-10T00:49:27.020Z DEBUG statecache/statecache.go:131 statecache - commit {"block": "871c64a36a39760e08b1e5a33c7daff8c82e789f28f5943382521c786e2239c6", "bc_hits": 80, "bc_miss": 0, "sc_hits": 16632275, "sc_miss": 4957, "duration": "421.486µs"} 2025-11-10T00:49:27.020Z DEBUG miner/worker.go:53 message {"msg": {"code":"verify_block","value":"Verify Block"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71"} 2025-11-10T00:49:27.020Z INFO miner/protocol_block.go:1316 generate block (assemble+update+sign) {"round": 179694, "block_size": 2, "reused_txns": 0, "reused_txns": 0, "time": "15.837391ms", "block": "871c64a36a39760e08b1e5a33c7daff8c82e789f28f5943382521c786e2239c6", "prev_block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681", "begin_state_hash": "50d056c1e4539c976a2fc0c7f11be0553b16a2a4db8f7071e14873539f761761", "block_state_hash": "a46f078959be7aec8e2582ca3a5b2ba3afc0f676786c5ffd8be4b02deebe2bd8", "computed_state_hash": "a46f078959be7aec8e2582ca3a5b2ba3afc0f676786c5ffd8be4b02deebe2bd8", "changes": 11, "state_status": 4, "iteration_count": 0} 2025-11-10T00:49:27.020Z DEBUG miner/protocol_block.go:1305 generate block (assemble+update) {"round": 179694, "txns": 2, "time": "15.604227ms"} 2025-11-10T00:49:27.020Z DEBUG miner/protocol_block.go:1282 generate block (assemble) {"round": 179694, "txns": 2, "time": "15.546937ms"} 2025-11-10T00:49:27.019Z DEBUG chain/state.go:961 Updating nonce {"client": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "new_nonce": 92492} 2025-11-10T00:49:27.018Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T00:49:27.018Z INFO chain/state.go:533 SC executed {"client id": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "block": "", "round": 179694, "prev_state_hash": "50d056c1e4539c976a2fc0c7f11be0553b16a2a4db8f7071e14873539f761761", "txn_hash": "ddb5764c7ce993421d8ab9cc7714de3114cac936b8004bb77045e8251ed969b4", "txn_nonce": 92492, "txn_func": "generate_challenge", "txn_status": 0, "txn_exec_time": "363.765µs", "begin client state": "06c9a4f7881862f428f4fe9870934d3d8bd775d6146901acee8762f2594c78fd", "current_root": "06c9a4f7881862f428f4fe9870934d3d8bd775d6146901acee8762f2594c78fd", "mpt_cache_hit": 10, "mpt_cache_miss": 0, "output": "OpenChallenges generated"} 2025-11-10T00:49:27.018Z INFO storagesc/challenge.go:1191 skipping generate challenge: empty blobber challenge partition 2025-11-10T00:49:27.018Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "eaf4195ad8a6c0bd8f90e9b28f4ba3b4938ddc60155952285997f669446bb502"} 2025-11-10T00:49:27.018Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T00:49:27.017Z DEBUG chain/protocol_view_change.go:424 [mvc] nonce, set nonce in getCurrentSelfNonce {"nonce": 92491} 2025-11-10T00:49:27.017Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T00:49:27.017Z DEBUG chain/protocol_view_change.go:431 [mvc] nonce, get current miner nonce {"minerId": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea"} 2025-11-10T00:49:27.016Z DEBUG chain/state.go:961 Updating nonce {"client": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "new_nonce": 92491} 2025-11-10T00:49:27.015Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T00:49:27.015Z INFO chain/state.go:533 SC executed {"client id": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "block": "", "round": 179694, "prev_state_hash": "50d056c1e4539c976a2fc0c7f11be0553b16a2a4db8f7071e14873539f761761", "txn_hash": "6c1901c1d51be9772cc0341863f96cfff1d79bed3ed34f07a8fb96dd92f2d397", "txn_nonce": 92491, "txn_func": "payFees", "txn_status": 0, "txn_exec_time": "8.19165ms", "begin client state": "50d056c1e4539c976a2fc0c7f11be0553b16a2a4db8f7071e14873539f761761", "current_root": "48ce5f8ee6da6e1ff2305d493adb729c8736ce85175567b50137802c1dc8d6a4", "mpt_cache_hit": 44, "mpt_cache_miss": 0, "output": ""} 2025-11-10T00:49:27.015Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T00:49:27.015Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T00:49:27.014Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T00:49:27.014Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T00:49:27.008Z ERROR minersc/global_node.go:372 failed to get current magic block {"error": "value not present"} 0chain.net/smartcontract/minersc.(*GlobalNode).prevMagicBlock /0chain/code/go/0chain.net/smartcontract/minersc/global_node.go:372 0chain.net/smartcontract/minersc.getRegisterShardersInMagicBlock /0chain/code/go/0chain.net/smartcontract/minersc/fees.go:659 0chain.net/smartcontract/minersc.(*MinerSmartContract).payFees /0chain/code/go/0chain.net/smartcontract/minersc/fees.go:519 0chain.net/smartcontract/minersc.(*MinerSmartContract).Execute /0chain/code/go/0chain.net/smartcontract/minersc/sc.go:139 0chain.net/chaincore/smartcontract.ExecuteWithStats /0chain/code/go/0chain.net/chaincore/smartcontract/handler.go:52 0chain.net/chaincore/smartcontract.ExecuteSmartContract /0chain/code/go/0chain.net/chaincore/smartcontract/handler.go:67 0chain.net/chaincore/chain.(*Chain).ExecuteSmartContract.func1 /0chain/code/go/0chain.net/chaincore/chain/state.go:158 2025-11-10T00:49:27.008Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "6dba10422e368813802877a85039d3985d96760ed844092319743fb3a76712d9d2208fe938b7465b9c5dc571053986cf8dbf3585fb36399f98ea569c42f50b76"} 2025-11-10T00:49:27.008Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "6dba10422e368813802877a85039d3985d96760ed844092319743fb3a76712d9b5e8a1650666fdd3a9de7855b6da63ab629b1701f23738477e2325f7ca2150ac"} 2025-11-10T00:49:27.007Z DEBUG minersc/fees.go:480 pay_fees, got miner id successfully {"miner id": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "round": 179694, "block": ""} 2025-11-10T00:49:27.007Z INFO miner/m_handler.go:242 Reject VRFShare: VRF is complete for this round {"vrfs_round_num": 179694, "vrfs_sender_index": 0, "vrfs_round_num": 179694} 2025-11-10T00:49:27.007Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T00:49:27.007Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T00:49:27.007Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T00:49:27.007Z DEBUG chain/protocol_view_change.go:424 [mvc] nonce, set nonce in getCurrentSelfNonce {"nonce": 92490} 2025-11-10T00:49:27.007Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\u001c\ufffd\ufffd\u0011\u0017}\ufffd\ufffd\ufffdQ\ufffd\ufffd4\ufffd<\ufffd\ufffdT\ufffd\ufffdbһ5/6t\ufffdz\ufffd\ufffdV"} 2025-11-10T00:49:27.007Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "E|\u0013\ufffd\tJ\t\ufffdZ9΃\u000cݔ\u0000@x\ufffdS\ufffd!R\u0001\ufffdCt\ufffdP\u0011d\u0005"} 2025-11-10T00:49:27.006Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\u0012\u0001\ufffd\ufffd\ufffd\ufffd\ufffd]o\u0013?\ufffd\ufffd_\ufffd۾\ufffdS\u0010\ufffd#\ufffd&l\ufffd\r\n\ufffd\ufffd\u001d2"} 2025-11-10T00:49:27.006Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\ufffd\ufffdv\ufffd\ufffdl\ufffdr\ufffd\ufffd\ufffdF\ufffd+\ufffd\u0017H{~\ufffd\ufffd\ufffdi\ufffdO\ufffd\u0000\ufffd\ufffd\ufffd\ufffd\ufffd"} 2025-11-10T00:49:27.006Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "<\ufffd>\ufffds\ufffd)z\ufffd\ufffd%|F\ufffd\u001a\ufffd3k\u00119\u0013\ufffdf\ufffd\ufffd\ufffd\ufffdݬ)\u0010u"} 2025-11-10T00:49:27.006Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "P\ufffdV\ufffd\ufffdS\ufffd\ufffdj/\ufffd\ufffd\ufffd\u001b\ufffdU;\u0016\ufffd\ufffdۏpq\ufffdHsS\ufffdv\u0017a"} 2025-11-10T00:49:27.006Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T00:49:27.006Z DEBUG chain/protocol_view_change.go:431 [mvc] nonce, get current miner nonce {"minerId": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea"} 2025-11-10T00:49:27.006Z INFO memorystore/collection.go:65 Redis returned 0 rows after seclect 2025-11-10T00:49:27.006Z INFO miner/protocol_block.go:1112 generate block starting iteration {"round": 179694, "prev_block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681", "prev_state_hash": "50d056c1e4539c976a2fc0c7f11be0553b16a2a4db8f7071e14873539f761761"} 2025-11-10T00:49:27.006Z DEBUG statecache/statecache.go:173 state cache - see gap {"block": "0a1d0709e7b36484236f49ba15512201289834420ea9115ff09c91df3763330c"} 2025-11-10T00:49:27.005Z DEBUG statecache/statecache.go:173 state cache - see gap {"block": "0a1d0709e7b36484236f49ba15512201289834420ea9115ff09c91df3763330c"} 2025-11-10T00:49:27.005Z DEBUG statecache/statecache.go:173 state cache - see gap {"block": "0a1d0709e7b36484236f49ba15512201289834420ea9115ff09c91df3763330c"} 2025-11-10T00:49:27.005Z DEBUG statecache/statecache.go:173 state cache - see gap {"block": "0a1d0709e7b36484236f49ba15512201289834420ea9115ff09c91df3763330c"} 2025-11-10T00:49:27.004Z DEBUG statecache/statecache.go:173 state cache - see gap {"block": "0a1d0709e7b36484236f49ba15512201289834420ea9115ff09c91df3763330c"} 2025-11-10T00:49:27.004Z DEBUG statecache/statecache.go:173 state cache - see gap {"block": "0a1d0709e7b36484236f49ba15512201289834420ea9115ff09c91df3763330c"} 2025-11-10T00:49:27.004Z INFO miner/m_handler.go:242 Reject VRFShare: VRF is complete for this round {"vrfs_round_num": 179694, "vrfs_sender_index": 0, "vrfs_round_num": 179694} 2025-11-10T00:49:27.004Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 179694, "randk": 0, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T00:49:27.004Z DEBUG miner/protocol_round.go:467 Setting LFMB round/hash for a block {"rn": 179694, "mc.crn": 179694, "rnoff": 179669, "nvc": 0, "r": 0, "h": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "b.lfmbr": 0, "b.lfmbh": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4"} 2025-11-10T00:49:27.004Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"vrf_share","value":"VRF Share"}, "sender_index": 0, "id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "duration": "2.211142ms"} 2025-11-10T00:49:27.004Z INFO miner/protocol_round.go:830 Starting round verification {"round": 179694, "delta": "180ms"} 2025-11-10T00:49:27.004Z INFO round/entity.go:618 get miners by rank {"num_miners": 3, "round": 179694, "r.minerPerm": [1, 2, 0]} 2025-11-10T00:49:27.004Z INFO miner/protocol_round.go:340 *** TOC_FIX starting round block generation *** {"round": 179694, "index": 2, "rank": 0, "timeout_count": 0, "random_seed": -4604624124942038346, "lf_round": 179690} 2025-11-10T00:49:27.004Z INFO miner/protocol_bls.go:591 Starting round with vrf {"round": 179694, "roundtimeout": 0, "rseed": -4604624124942038346, "prev_round": 179693, "Prev_rseed": 0} 2025-11-10T00:49:27.004Z DEBUG miner/protocol_bls.go:542 DKG computeRBO {"round": 179694} 2025-11-10T00:49:27.004Z INFO miner/protocol_bls.go:524 receive bls sign {"round": 179694, "group_signature": "1 155afa05b868bd9cef20fde704c4ad570414bf4ce3192d24d4f4506abeb0ea95 c1b239d29562eae78a11c16753e8dabf3df144b06af4b01d42a919d2704951a", "rboOutput": "c01916c134a2cab632cefade8ef586e9da6ece93a18e9cd3f88e51ed1da1e245", "dkg_starting_round": 0, "dkg_mb_number": 1} 2025-11-10T00:49:27.003Z DEBUG miner/protocol_bls.go:496 VRF Hurray we've threshold BLS shares {"round": 179694, "round pointer": "0xc018adf0e0"} 2025-11-10T00:49:27.003Z DEBUG round/entity.go:684 add_vrf_share {"round": 179694, "round_vrf_num": 2, "threshold": 2} 2025-11-10T00:49:27.003Z INFO miner/protocol_bls.go:430 verified vrf {"round": 179694, "node_id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341", "share": "1 4f20a8d8ab6bf272bd850e858b2bdb002d5dd3775d8fc1805db8ef351527e4e 912ff7b1a92d89a7258912e3d40041e1896382776a4453e8f64f1a53907dfcb", "from": "196b96df7631e00d339f9a25131927c4", "message": "179694015218a0c64596b27"} 2025-11-10T00:49:27.002Z DEBUG bls/dkg.go:396 dkg verify {"id": "196b96df7631e00d339f9a25131927c4", "key": "1 1f8c72cc3a6b74f6ad7528172b64afe3dc42ee1987495659fe2cf34e749caa7c 20957b4d25e7b5fb1e32d4e3b93e2b73dad7f118efb6dae28715e4ad627b0fff 14259a6ddf4b44c83c1389bd8ed1fc47c1b099c5986bb33923bbcbb25d30054a 2100bb7434dadde1a5ed8545748d0958955bcd21e06cf170f78dbda35a9e04b7", "msg": "179694015218a0c64596b27", "sig": "1 4f20a8d8ab6bf272bd850e858b2bdb002d5dd3775d8fc1805db8ef351527e4e 912ff7b1a92d89a7258912e3d40041e1896382776a4453e8f64f1a53907dfcb"} 2025-11-10T00:49:27.002Z INFO miner/protocol_bls.go:265 BLS sign VRF share calculated for {"round": 179694, "round_timeout": 0, "prev_rseed": 1522649934855760679, "prev round vrf random seed": "15218a0c64596b27", "bls_msg": "179694015218a0c64596b27"} 2025-11-10T00:49:27.002Z INFO miner/protocol_bls.go:364 DKG AddVRFShare {"round": 179694, "round_vrf_num": 1, "threshold": 2, "sender": 0, "round_timeout_count": 0, "vrf_timeout_count": 0, "vrf_share": "1 4f20a8d8ab6bf272bd850e858b2bdb002d5dd3775d8fc1805db8ef351527e4e 912ff7b1a92d89a7258912e3d40041e1896382776a4453e8f64f1a53907dfcb"} 2025-11-10T00:49:27.002Z DEBUG miner/protocol_receive.go:26 handle vrf share {"round": 179694, "vrf_timeout_count": 0, "sender_index": 0} 2025-11-10T00:49:27.002Z DEBUG miner/worker.go:53 message {"msg": {"code":"vrf_share","value":"VRF Share"}, "sender_index": 0, "id": "96b96df7631e00d339f9a25131927c43cba9f130b075f4af09e8934c21173341"} 2025-11-10T00:49:26.999Z INFO chain/entity.go:1721 delete blocks below round {"round": 179694, "below_round": 179640, "before": 1762735706, "total": 312, "count": 0} 2025-11-10T00:49:26.999Z DEBUG chain/protocol_round.go:334 finalize round - block has less than 3 confirmation 2025-11-10T00:49:26.999Z DEBUG chain/protocol_round.go:334 finalize round - block has less than 3 confirmation 2025-11-10T00:49:26.999Z INFO chain/protocol_round.go:402 finalize round - finalize block success {"round": 179690, "block": "8d6cac0fd1ce90db18ab77301e37732be643cbe64cb0f5503b9eca9060026bd4", "duration": "3.786395ms"} 2025-11-10T00:49:26.999Z DEBUG chain/worker.go:230 finalize block processed {"round": 179690, "duration": "3.749025ms"} 2025-11-10T00:49:26.999Z DEBUG chain/protocol_block.go:612 finalized block - done {"round": 179690, "block": "8d6cac0fd1ce90db18ab77301e37732be643cbe64cb0f5503b9eca9060026bd4", "duration": "3.635962ms"} 2025-11-10T00:49:26.999Z INFO chain/entity.go:2366 config has been updated successfully {"start of round": 179690} 2025-11-10T00:49:26.999Z DEBUG transaction/worker.go:253 [mvc] see no old txns {"clientID": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "nonce": 92487} 2025-11-10T00:49:26.999Z INFO memorystore/collection.go:65 Redis returned 0 rows after seclect 2025-11-10T00:49:26.999Z 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-10T00:49:26.999Z DEBUG transaction/worker.go:221 [mvc] remove old nonce txns {"clientID": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "nonce": 92487} 2025-11-10T00:49:26.998Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "Z\ufffd\ufffdo\ufffd\ufffd\ufffd\ufffdm\ufffd\ufffd\ufffdu\ufffdV ~a\ufffd /D\ufffd\u0011\ufffd\ufffd\ufffd\ufffdZ\u0005\ufffd\ufffd"} 2025-11-10T00:49:26.998Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\ufffd-<1n\ufffd\ufffdD\ufffd\ufffdå\ufffd\u0017\ufffd\t\ufffd\u001eE\ufffd]\ufffd\ufffd\u0001\ufffd\ufffdƈ;\ufffdx"} 2025-11-10T00:49:26.998Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\ufffd\ufffd[\\W2\ufffd\ufffd}\ufffd\u0006,\u001f7YҺ\ufffd\u000c\ufffd\u0008Rr\ufffd3dMW\ufffd\ufffd\ufffd\ufffd"} 2025-11-10T00:49:26.998Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\ufffd,rpeˮ\ufffd\ufffd>\ufffd\ufffd ݝp\u001d\ufffd\u0014$\u0011F\ufffdAB\ufffd\ufffd\\oQ`f"} 2025-11-10T00:49:26.998Z DEBUG chain/lfb_round_node.go:33 [mvc] store lfb {"round": 179690, "block": "8d6cac0fd1ce90db18ab77301e37732be643cbe64cb0f5503b9eca9060026bd4", "mb number": 1} 2025-11-10T00:49:26.998Z DEBUG chain/worker.go:443 BC is moving {"current_lfb_round": 179690, "last_round": 179689} 2025-11-10T00:49:26.998Z DEBUG chain/entity.go:2269 set lfb {"round": 179690, "block": "8d6cac0fd1ce90db18ab77301e37732be643cbe64cb0f5503b9eca9060026bd4", "state_computed": true} 2025-11-10T00:49:26.998Z INFO transaction/worker.go:164 cleaning transactions {"collection": "collection.txn:0afc093ffb509f059c55478bc1a60351cef7b4e9c008a53a6cc8241ca8617dfe", "missing_count": 2, "txns": ["7cebee6865ec1012e379cbaced1b4cb8b5686d216a096e2a1c9cfadb3dad45c1", "405329c278aedd080b9667efb107e7109e168306bfbbe7c717e230e8cfd26126"], "past txns": []} 2025-11-10T00:49:26.998Z INFO memorystore/collection.go:65 Redis returned 0 rows after seclect 2025-11-10T00:49:26.998Z DEBUG chain/state.go:128 finalize round - rebased current state db {"round": 179690, "block": "8d6cac0fd1ce90db18ab77301e37732be643cbe64cb0f5503b9eca9060026bd4", "state hash": "a81b8ab5a51f1a1276d7b781454ef6967b44ae4127abb45658d08bcb3cb8096d"} 2025-11-10T00:49:26.998Z DEBUG util/mpt_nodedb.go:556 LevelNodeDB rebase db 2025-11-10T00:49:26.998Z DEBUG chain/protocol_block.go:424 finalize block - record dead nodes {"round": 179690, "block": "8d6cac0fd1ce90db18ab77301e37732be643cbe64cb0f5503b9eca9060026bd4", "num dead nodes": 12} 2025-11-10T00:49:26.998Z DEBUG transaction/worker.go:124 cleaning past transactions 2025-11-10T00:49:26.998Z DEBUG miner/round.go:238 Round clear - cancel verification 2025-11-10T00:49:26.997Z DEBUG miner/chain.go:313 delete txns {"txns": ["7cebee6865ec1012e379cbaced1b4cb8b5686d216a096e2a1c9cfadb3dad45c1", "405329c278aedd080b9667efb107e7109e168306bfbbe7c717e230e8cfd26126"]} 2025-11-10T00:49:26.997Z INFO miner/protocol_block.go:619 update finalized block (debug transaction) {"txn": "405329c278aedd080b9667efb107e7109e168306bfbbe7c717e230e8cfd26126", "block": "8d6cac0fd1ce90db18ab77301e37732be643cbe64cb0f5503b9eca9060026bd4"} 2025-11-10T00:49:26.997Z INFO miner/protocol_block.go:619 update finalized block (debug transaction) {"txn": "7cebee6865ec1012e379cbaced1b4cb8b5686d216a096e2a1c9cfadb3dad45c1", "block": "8d6cac0fd1ce90db18ab77301e37732be643cbe64cb0f5503b9eca9060026bd4"} 2025-11-10T00:49:26.997Z INFO miner/protocol_block.go:613 update finalized block {"round": 179690, "block": "8d6cac0fd1ce90db18ab77301e37732be643cbe64cb0f5503b9eca9060026bd4", "lf_round": 179689, "current_round": 179694, "weight": 1} 2025-11-10T00:49:26.997Z DEBUG chain/protocol_block.go:409 MPT state node stat - inc {"node num": -342598, "change num": 9, "delete num": 12} 2025-11-10T00:49:26.997Z INFO block/entity.go:1195 save state {"round": 179690, "block": "8d6cac0fd1ce90db18ab77301e37732be643cbe64cb0f5503b9eca9060026bd4", "block_size": 2, "changes": 9, "client_state": "a81b8ab5a51f1a1276d7b781454ef6967b44ae4127abb45658d08bcb3cb8096d", "duration": "1.452501ms"} 2025-11-10T00:49:26.997Z INFO miner/protocol_bls.go:489 Not yet reached threshold {"vrfShares_num": 1, "threshold": 2, "round": 179694} 2025-11-10T00:49:26.997Z DEBUG round/entity.go:684 add_vrf_share {"round": 179694, "round_vrf_num": 1, "threshold": 2} 2025-11-10T00:49:26.997Z INFO miner/protocol_bls.go:430 verified vrf {"round": 179694, "node_id": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "share": "1 2474c83b7a978db8435bbee638747722a08c25af53bb415ab3f5a29651b6eb11 250a3a8456cc71375fa8480ca07fbf3d19463f84019f14ac3c5509b7df440fb5", "from": "1c3227e496fdf3c9aa604f3470a2bbd1", "message": "179694015218a0c64596b27"} 2025-11-10T00:49:26.996Z DEBUG util/merkle_patricia_trie.go:272 MPT save changes success {"duration": "1.051115ms"} 2025-11-10T00:49:26.996Z DEBUG util/mpt_node_change.go:156 MPT - update changes done {"changes": 9} 2025-11-10T00:49:26.996Z DEBUG util/mpt_node_change.go:150 MPT - update changes {"changes": 9} 2025-11-10T00:49:26.996Z DEBUG bls/dkg.go:396 dkg verify {"id": "1c3227e496fdf3c9aa604f3470a2bbd1", "key": "1 6603e20478fac2c72a61b85056977b92696b8fffd408d8acac0e1f47aed3f96 1501242ed9000d9c6a02764160261164a52360a692c34ed452ff097bc90ee9b3 7f8aaa178d31fa4cbd0c1974768dfa4921e29405754ebf8d2c163a774b741a2 24515e04bd685a5559260f5d1868e5ea11abaf21f55a56aee52c15d9f3c2b053", "msg": "179694015218a0c64596b27", "sig": "1 2474c83b7a978db8435bbee638747722a08c25af53bb415ab3f5a29651b6eb11 250a3a8456cc71375fa8480ca07fbf3d19463f84019f14ac3c5509b7df440fb5"} 2025-11-10T00:49:26.995Z INFO miner/protocol_bls.go:265 BLS sign VRF share calculated for {"round": 179694, "round_timeout": 0, "prev_rseed": 1522649934855760679, "prev round vrf random seed": "15218a0c64596b27", "bls_msg": "179694015218a0c64596b27"} 2025-11-10T00:49:26.995Z INFO miner/protocol_bls.go:364 DKG AddVRFShare {"round": 179694, "round_vrf_num": 0, "threshold": 2, "sender": 2, "round_timeout_count": 0, "vrf_timeout_count": 0, "vrf_share": "1 2474c83b7a978db8435bbee638747722a08c25af53bb415ab3f5a29651b6eb11 250a3a8456cc71375fa8480ca07fbf3d19463f84019f14ac3c5509b7df440fb5"} 2025-11-10T00:49:26.995Z INFO miner/protocol_round.go:78 add_my_vrf_share {"round": 179694, "round_timeout": 0, "dkg_starting_round": 0, "dkg_mb_number": 1, "pr_seed": 1522649934855760679, "pr_vrf_seed": "15218a0c64596b27", "share": "1 2474c83b7a978db8435bbee638747722a08c25af53bb415ab3f5a29651b6eb11 250a3a8456cc71375fa8480ca07fbf3d19463f84019f14ac3c5509b7df440fb5"} 2025-11-10T00:49:26.995Z DEBUG miner/protocol_bls.go:305 get_bls_share {"round": 179694, "rtc": 0, "dkg_pi": "1 6603e20478fac2c72a61b85056977b92696b8fffd408d8acac0e1f47aed3f96 1501242ed9000d9c6a02764160261164a52360a692c34ed452ff097bc90ee9b3 7f8aaa178d31fa4cbd0c1974768dfa4921e29405754ebf8d2c163a774b741a2 24515e04bd685a5559260f5d1868e5ea11abaf21f55a56aee52c15d9f3c2b053", "dkg_sr": 0, "mb_sr": 0, "share": "1 2474c83b7a978db8435bbee638747722a08c25af53bb415ab3f5a29651b6eb11 250a3a8456cc71375fa8480ca07fbf3d19463f84019f14ac3c5509b7df440fb5"} 2025-11-10T00:49:26.995Z INFO round/entity.go:618 get miners by rank {"num_miners": 3, "round": 179690, "r.minerPerm": [0, 1, 2]} 2025-11-10T00:49:26.995Z INFO chain/protocol_block.go:363 finalize block -- round {"round": {"number":179690,"round_random_seed":3997756756987517454,"block_hash":"8d6cac0fd1ce90db18ab77301e37732be643cbe64cb0f5503b9eca9060026bd4","vrf_output":"377ae296e6a89a0e218c0b8564d0d256303441d2c9b64881f5f9ea698fa851a7"}, "block": "8d6cac0fd1ce90db18ab77301e37732be643cbe64cb0f5503b9eca9060026bd4"} 2025-11-10T00:49:26.995Z INFO chain/protocol_block.go:328 finalize block {"round": 179690, "current_round": 179694, "lf_round": 179689, "hash": "8d6cac0fd1ce90db18ab77301e37732be643cbe64cb0f5503b9eca9060026bd4", "round_rank": 0, "state": 7} 2025-11-10T00:49:26.995Z DEBUG chain/worker.go:262 start to finalize block {"round": 179690, "block": "8d6cac0fd1ce90db18ab77301e37732be643cbe64cb0f5503b9eca9060026bd4", "prev block": "81b9a5e08f011f1ed6fd01f45f1fdfd048abe59b986cf369546ad9d71d3410aa"} 2025-11-10T00:49:26.995Z INFO chain/protocol_round.go:359 finalize round {"round": 179690, "lfb round": 179692, "block": "8d6cac0fd1ce90db18ab77301e37732be643cbe64cb0f5503b9eca9060026bd4"} 2025-11-10T00:49:26.995Z INFO chain/protocol_round.go:326 finalize round - latest finalized round {"round": 179693, "lfb round": 179692, "lfb block": "a5a02e57890ea331e739756d6aae95ddbc38ad762eea55963a4ad535152dc249"} 2025-11-10T00:49:26.995Z INFO chain/protocol_round.go:199 finalize round {"round": 179693, "plfb_round": 179689, "num_round_notarized": 1, "num_chain_notarized": 3} 2025-11-10T00:49:26.995Z DEBUG bls/dkg.go:356 dkg sign {"key": "21d97039e984194d599f2bf60c03d185c67ff756eba44a56ac9cf108c33c814a", "pi": "1 6603e20478fac2c72a61b85056977b92696b8fffd408d8acac0e1f47aed3f96 1501242ed9000d9c6a02764160261164a52360a692c34ed452ff097bc90ee9b3 7f8aaa178d31fa4cbd0c1974768dfa4921e29405754ebf8d2c163a774b741a2 24515e04bd685a5559260f5d1868e5ea11abaf21f55a56aee52c15d9f3c2b053"} 2025-11-10T00:49:26.995Z DEBUG chain/protocol_round.go:160 finalize round {"round": 179693, "lf_round": 179689} 2025-11-10T00:49:26.995Z DEBUG miner/protocol_bls.go:293 Sign msg with dkg {"msg": "179694015218a0c64596b27", "round": 179694, "dkg starting round": 0} 2025-11-10T00:49:26.995Z INFO miner/protocol_bls.go:265 BLS sign VRF share calculated for {"round": 179694, "round_timeout": 0, "prev_rseed": 1522649934855760679, "prev round vrf random seed": "15218a0c64596b27", "bls_msg": "179694015218a0c64596b27"} 2025-11-10T00:49:26.995Z INFO miner/protocol_bls.go:283 DKG getBlsShare {"Round Number": 179694} 2025-11-10T00:49:26.995Z INFO miner/protocol_round.go:244 StartNextRound - add VRF {"round": 179694} 2025-11-10T00:49:26.995Z INFO miner/round.go:40 Try to cancel block generation that have not been started yet {"round": 179693} 2025-11-10T00:49:26.995Z DEBUG miner/protocol_round.go:210 finalizedRound - cancel round verification {"round": 179693} 2025-11-10T00:49:26.995Z INFO chain/entity.go:2016 Moving to the next round {"next_round": 179694} 2025-11-10T00:49:26.995Z DEBUG miner/protocol_round.go:154 [wait not ahead] [2] not ahead, can move on {"round": 179693, "lfb tk round": 179689} 2025-11-10T00:49:26.995Z DEBUG miner/protocol_round.go:123 [wait not ahead] 2025-11-10T00:49:26.995Z DEBUG miner/protocol_round.go:991 verification_complete {"top_verified_rank": 0} 2025-11-10T00:49:26.995Z INFO miner/protocol_round.go:986 verification_complete {"round": 179693, "verified_blocks": 0} 2025-11-10T00:49:26.995Z DEBUG miner/protocol_round.go:943 verifyAndSend - finished successfully {"round": 179693, "block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681"} 2025-11-10T00:49:26.994Z INFO miner/round.go:44 Cancelling block generation {"round": 179693} 2025-11-10T00:49:26.994Z INFO miner/round.go:230 Cancelling verification {"round": 179693} 2025-11-10T00:49:26.994Z INFO miner/protocol_receive.go:456 process notarization - start next round {"new round": 179694} 2025-11-10T00:49:26.994Z DEBUG miner/protocol_round.go:1149 check block notarization - block notarized {"round": 179693, "block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681"} 2025-11-10T00:49:26.994Z DEBUG round/entity.go:344 reached notarization {"round": 179693} 2025-11-10T00:49:26.994Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 179693, "randk": 0, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T00:49:26.994Z INFO chain/entity.go:1571 Adding a notarized block for current round {"Round": 179693} 2025-11-10T00:49:26.994Z INFO chain/protocol_block.go:303 reached notarization - add tickets {"round": 179693, "current_round": 179693, "block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681", "tickets_num": 2} 2025-11-10T00:49:26.994Z INFO miner/protocol_round.go:920 verifyAndSend - sending verification ticket {"round": 179693, "block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681", "block_rank": 0, "RRS": 1522649934855760679} 2025-11-10T00:49:26.994Z INFO chain/protocol_block.go:319 reached notarization - merging tickets {"round": 179692, "current_round": 179693, "block": "a5a02e57890ea331e739756d6aae95ddbc38ad762eea55963a4ad535152dc249", "tickets_num": 3} 2025-11-10T00:49:26.994Z DEBUG miner/protocol_round.go:1069 verify round block - finished verification {"block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681"} 2025-11-10T00:49:26.994Z INFO miner/protocol_block.go:376 verify block successful {"round": 179693, "block_size": 1, "time": "13.840841ms", "block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681", "prev_block": "a5a02e57890ea331e739756d6aae95ddbc38ad762eea55963a4ad535152dc249", "state_hash": "50d056c1e4539c976a2fc0c7f11be0553b16a2a4db8f7071e14873539f761761", "state_status": 4} 2025-11-10T00:49:26.994Z DEBUG miner/protocol_block.go:374 SignBlock finished {"block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681", "spent": "179.522µs"} 2025-11-10T00:49:26.994Z DEBUG miner/protocol_block.go:367 VerifyBlockMagicBlock finished {"block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681", "spent": "550ns"} 2025-11-10T00:49:26.994Z DEBUG miner/protocol_block.go:360 verifySmartContracts finished {"block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681", "spent": "900ns"} 2025-11-10T00:49:26.994Z DEBUG miner/protocol_block.go:351 verify block - ComputeState finished {"round": 179693, "block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681", "spent": "10.94949ms"} 2025-11-10T00:49:26.994Z INFO block/entity.go:1034 compute state successful {"round": 179693, "block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681", "block ptr": "0xc0162292c0", "block_size": 1, "duration": "10.886089ms", "changes": 9, "begin_client_state": "6eb5ce484c6bd27d023c212e12da26da62b40351f4a8e9632461df347e8fd95e", "computed_state_hash": "50d056c1e4539c976a2fc0c7f11be0553b16a2a4db8f7071e14873539f761761", "block_state_hash": "50d056c1e4539c976a2fc0c7f11be0553b16a2a4db8f7071e14873539f761761", "prev_block": "a5a02e57890ea331e739756d6aae95ddbc38ad762eea55963a4ad535152dc249", "prev_block_client_state": "6eb5ce484c6bd27d023c212e12da26da62b40351f4a8e9632461df347e8fd95e"} 2025-11-10T00:49:26.994Z DEBUG statecache/statecache.go:131 statecache - commit {"block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681", "bc_hits": 55, "bc_miss": 0, "sc_hits": 16632195, "sc_miss": 4957, "duration": "325.254µs"} 2025-11-10T00:49:26.993Z DEBUG chain/state.go:961 Updating nonce {"client": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "new_nonce": 92322} 2025-11-10T00:49:26.992Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T00:49:26.992Z INFO chain/state.go:533 SC executed {"client id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681", "round": 179693, "prev_state_hash": "6eb5ce484c6bd27d023c212e12da26da62b40351f4a8e9632461df347e8fd95e", "txn_hash": "7be4d61f00a002b0c1f4348681d7859f1f9a8acce49362cb2c4a32154c4b1f91", "txn_nonce": 92322, "txn_func": "payFees", "txn_status": 1, "txn_exec_time": "8.680847ms", "begin client state": "6eb5ce484c6bd27d023c212e12da26da62b40351f4a8e9632461df347e8fd95e", "current_root": "67971278206093ecae441d7471620c240b02f00a5866a8238c31e2c8bc2f6d60", "mpt_cache_hit": 43, "mpt_cache_miss": 0, "output": ""} 2025-11-10T00:49:26.991Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T00:49:26.991Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T00:49:26.991Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T00:49:26.990Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T00:49:26.986Z DEBUG chain/entity.go:440 process block, no block in buffer {"current round": 179693} 2025-11-10T00:49:26.986Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"verification_ticket","value":"Verification Ticket"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "duration": "1.509182ms"} 2025-11-10T00:49:26.986Z INFO miner/protocol_round.go:1127 checkBlockNotarization -- block is not Notarized. Returning {"round": 179693, "block hash": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681"} 2025-11-10T00:49:26.986Z INFO chain/protocol_block.go:225 not reached notarization {"mb_sr": 0, "active_miners": 3, "threshold": 2, "num_signatures": 1, "current_round": 179693, "round": 179693} 2025-11-10T00:49:26.986Z DEBUG miner/protocol_receive.go:298 handle vt. msg - verify ticket successfully {"round": 179693, "block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681", "verifier": 0} 2025-11-10T00:49:26.984Z ERROR minersc/global_node.go:372 failed to get current magic block {"error": "value not present"} 0chain.net/smartcontract/minersc.(*GlobalNode).prevMagicBlock /0chain/code/go/0chain.net/smartcontract/minersc/global_node.go:372 0chain.net/smartcontract/minersc.getRegisterShardersInMagicBlock /0chain/code/go/0chain.net/smartcontract/minersc/fees.go:659 0chain.net/smartcontract/minersc.(*MinerSmartContract).payFees /0chain/code/go/0chain.net/smartcontract/minersc/fees.go:519 0chain.net/smartcontract/minersc.(*MinerSmartContract).Execute /0chain/code/go/0chain.net/smartcontract/minersc/sc.go:139 0chain.net/chaincore/smartcontract.ExecuteWithStats /0chain/code/go/0chain.net/chaincore/smartcontract/handler.go:52 0chain.net/chaincore/smartcontract.ExecuteSmartContract /0chain/code/go/0chain.net/chaincore/smartcontract/handler.go:67 0chain.net/chaincore/chain.(*Chain).ExecuteSmartContract.func1 /0chain/code/go/0chain.net/chaincore/chain/state.go:158 2025-11-10T00:49:26.984Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "6dba10422e368813802877a85039d3985d96760ed844092319743fb3a76712d9d2208fe938b7465b9c5dc571053986cf8dbf3585fb36399f98ea569c42f50b76"} 2025-11-10T00:49:26.984Z DEBUG miner/worker.go:53 message {"msg": {"code":"verification_ticket","value":"Verification Ticket"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71"} 2025-11-10T00:49:26.984Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "6dba10422e368813802877a85039d3985d96760ed844092319743fb3a76712d9b5e8a1650666fdd3a9de7855b6da63ab629b1701f23738477e2325f7ca2150ac"} 2025-11-10T00:49:26.984Z DEBUG minersc/fees.go:480 pay_fees, got miner id successfully {"miner id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "round": 179693, "block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681"} 2025-11-10T00:49:26.984Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T00:49:26.983Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T00:49:26.983Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T00:49:26.983Z DEBUG miner/protocol_block.go:339 ValidateBlockCost {"round": 179693, "hash": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681", "calculated cost": 0} 2025-11-10T00:49:26.983Z DEBUG miner/m_handler.go:365 handle vt. msg - verification ticket {"round": 179693, "block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681"} 2025-11-10T00:49:26.983Z DEBUG miner/protocol_block.go:305 ValidateTransactions finished {"block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681", "spent": "1.38124ms"} 2025-11-10T00:49:26.981Z DEBUG miner/protocol_block.go:299 GetPreviousBlock finished {"block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681", "spent": "760ns"} 2025-11-10T00:49:26.981Z DEBUG miner/protocol_block.go:292 VerifyBlockMagicBlockReference finished {"block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681", "spent": "2.5µs"} 2025-11-10T00:49:26.981Z DEBUG miner/protocol_block.go:286 Validating finished {"block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681", "spent": "836.832µs"} 2025-11-10T00:49:26.980Z DEBUG miner/protocol_round.go:1067 verify round block - started verification {"block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681"} 2025-11-10T00:49:26.980Z DEBUG miner/protocol_round.go:1040 verify round block {"round": 179693, "block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681"} 2025-11-10T00:49:26.980Z DEBUG miner/protocol_round.go:865 verifyAndSend - started {"block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681"} 2025-11-10T00:49:26.980Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 179693, "randk": 1, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T00:49:26.980Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 179693, "randk": 0, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T00:49:26.980Z INFO miner/protocol_round.go:951 Started main verification loop {"round": 179693} 2025-11-10T00:49:26.910Z DEBUG chain/protocol_lfb_ticket.go:386 update lfb ticket - ticket.Round <= latest.Round {"ticket.Round": 179689, "latest.Round": 179689} 2025-11-10T00:49:26.895Z DEBUG chain/protocol_lfb_ticket.go:386 update lfb ticket - ticket.Round <= latest.Round {"ticket.Round": 179689, "latest.Round": 179689} 2025-11-10T00:49:26.886Z DEBUG chain/entity.go:440 process block, no block in buffer {"current round": 179693} 2025-11-10T00:49:26.817Z DEBUG miner/protocol_round.go:1028 verify block - pending {"round": 179693, "block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681"} 2025-11-10T00:49:26.817Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 179693, "randk": 0, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T00:49:26.817Z DEBUG miner/protocol_round.go:759 update prev block notarization, already notarized {"round": 179692, "block": "a5a02e57890ea331e739756d6aae95ddbc38ad762eea55963a4ad535152dc249"} 2025-11-10T00:49:26.817Z DEBUG miner/protocol_receive.go:130 verify block processed {"round": 179693, "block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681"} 2025-11-10T00:49:26.817Z DEBUG miner/round.go:143 Adding block to verifyChannel {"round": 179693, "block hash": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681", "magic block": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "magic block round": 0} 2025-11-10T00:49:26.816Z INFO miner/protocol_round.go:803 adding block to verify {"round": 179693, "block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681", "prev_block": "a5a02e57890ea331e739756d6aae95ddbc38ad762eea55963a4ad535152dc249", "state_hash": "50d056c1e4539c976a2fc0c7f11be0553b16a2a4db8f7071e14873539f761761", "weight": 1} 2025-11-10T00:49:26.816Z INFO miner/protocol_round.go:613 handle verify block - added block for ticket verification {"round": 179693, "block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681", "magic block": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "magic block round": 0} 2025-11-10T00:49:26.816Z INFO chain/protocol_block.go:225 not reached notarization {"mb_sr": 0, "active_miners": 3, "threshold": 2, "num_signatures": 0, "current_round": 179693, "round": 179693} 2025-11-10T00:49:26.816Z DEBUG miner/protocol_receive.go:169 verify block {"round": 179693, "block": "9e712ccf27126f4ccb9c4ce04d566ee93d4ed58d8482a502ec47983cbafc3681"} 2025-11-10T00:49:26.815Z DEBUG miner/worker.go:73 message (done) {"msg": {"code":"verify_block","value":"Verify Block"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71", "duration": "68.811µs"} 2025-11-10T00:49:26.815Z DEBUG miner/worker.go:53 message {"msg": {"code":"verify_block","value":"Verify Block"}, "sender_index": 0, "id": "8f9a15b9551f8552a19cf4750ef14bff3bbac83bc1decd4d5a013a7f36f7ef71"} 2025-11-10T00:49:26.814Z DEBUG miner/protocol_round.go:1028 verify block - pending {"round": 179693, "block": "17f3a6fb34688489eae9cfc5398f8aea411a5d5c5e8a7aea792847694489885a"} 2025-11-10T00:49:26.814Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 179693, "randk": 1, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T00:49:26.814Z DEBUG miner/round.go:143 Adding block to verifyChannel {"round": 179693, "block hash": "17f3a6fb34688489eae9cfc5398f8aea411a5d5c5e8a7aea792847694489885a", "magic block": "ed79cae70d439c11258236da1dfa6fc550f7cc569768304623e8fbd7d70efae4", "magic block round": 0} 2025-11-10T00:49:26.814Z INFO miner/protocol_round.go:803 adding block to verify {"round": 179693, "block": "17f3a6fb34688489eae9cfc5398f8aea411a5d5c5e8a7aea792847694489885a", "prev_block": "a5a02e57890ea331e739756d6aae95ddbc38ad762eea55963a4ad535152dc249", "state_hash": "f916b2492ef2028ea31f32b9f51b947bc3a2210437d812fe1ca798bbd5ef9380", "weight": 0.5} 2025-11-10T00:49:26.814Z DEBUG chain/entity.go:2056 [mvc] set round rank {"round": 179693, "randk": 1, "mb_round": 0, "mb_number": 1, "mb_hash": "506391f07cabd7bfee330f979ba9baab498b721b748eb869ba2b5c054932c8bd"} 2025-11-10T00:49:26.814Z DEBUG statecache/statecache.go:131 statecache - commit {"block": "17f3a6fb34688489eae9cfc5398f8aea411a5d5c5e8a7aea792847694489885a", "bc_hits": 58, "bc_miss": 0, "sc_hits": 16632140, "sc_miss": 4957, "duration": "485.247µs"} 2025-11-10T00:49:26.813Z INFO miner/protocol_block.go:1316 generate block (assemble+update+sign) {"round": 179693, "block_size": 1, "reused_txns": 0, "reused_txns": 0, "time": "13.778951ms", "block": "17f3a6fb34688489eae9cfc5398f8aea411a5d5c5e8a7aea792847694489885a", "prev_block": "a5a02e57890ea331e739756d6aae95ddbc38ad762eea55963a4ad535152dc249", "begin_state_hash": "6eb5ce484c6bd27d023c212e12da26da62b40351f4a8e9632461df347e8fd95e", "block_state_hash": "f916b2492ef2028ea31f32b9f51b947bc3a2210437d812fe1ca798bbd5ef9380", "computed_state_hash": "f916b2492ef2028ea31f32b9f51b947bc3a2210437d812fe1ca798bbd5ef9380", "changes": 12, "state_status": 4, "iteration_count": 0} 2025-11-10T00:49:26.813Z DEBUG miner/protocol_block.go:1305 generate block (assemble+update) {"round": 179693, "txns": 1, "time": "13.537577ms"} 2025-11-10T00:49:26.813Z DEBUG miner/protocol_block.go:1282 generate block (assemble) {"round": 179693, "txns": 1, "time": "13.475866ms"} 2025-11-10T00:49:26.812Z DEBUG chain/state.go:961 Updating nonce {"client": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "new_nonce": 92491} 2025-11-10T00:49:26.811Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T00:49:26.811Z INFO chain/state.go:533 SC executed {"client id": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "block": "", "round": 179693, "prev_state_hash": "6eb5ce484c6bd27d023c212e12da26da62b40351f4a8e9632461df347e8fd95e", "txn_hash": "6177df39a3f3cca2d19f4179cb89ffc1855a66b268a005bf8f994ae51939b75a", "txn_nonce": 92491, "txn_func": "payFees", "txn_status": 0, "txn_exec_time": "8.339851ms", "begin client state": "6eb5ce484c6bd27d023c212e12da26da62b40351f4a8e9632461df347e8fd95e", "current_root": "5fcaf2f8c07b82cf7848d5120006b78247dbc1e5af562929930d839386cbf034", "mpt_cache_hit": 45, "mpt_cache_miss": 0, "output": ""} 2025-11-10T00:49:26.810Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T00:49:26.810Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T00:49:26.810Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T00:49:26.809Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:jason"} 2025-11-10T00:49:26.803Z ERROR minersc/global_node.go:372 failed to get current magic block {"error": "value not present"} 0chain.net/smartcontract/minersc.(*GlobalNode).prevMagicBlock /0chain/code/go/0chain.net/smartcontract/minersc/global_node.go:372 0chain.net/smartcontract/minersc.getRegisterShardersInMagicBlock /0chain/code/go/0chain.net/smartcontract/minersc/fees.go:659 0chain.net/smartcontract/minersc.(*MinerSmartContract).payFees /0chain/code/go/0chain.net/smartcontract/minersc/fees.go:519 0chain.net/smartcontract/minersc.(*MinerSmartContract).Execute /0chain/code/go/0chain.net/smartcontract/minersc/sc.go:139 0chain.net/chaincore/smartcontract.ExecuteWithStats /0chain/code/go/0chain.net/chaincore/smartcontract/handler.go:52 0chain.net/chaincore/smartcontract.ExecuteSmartContract /0chain/code/go/0chain.net/chaincore/smartcontract/handler.go:67 0chain.net/chaincore/chain.(*Chain).ExecuteSmartContract.func1 /0chain/code/go/0chain.net/chaincore/chain/state.go:158 2025-11-10T00:49:26.803Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "6dba10422e368813802877a85039d3985d96760ed844092319743fb3a76712d9d2208fe938b7465b9c5dc571053986cf8dbf3585fb36399f98ea569c42f50b76"} 2025-11-10T00:49:26.803Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "6dba10422e368813802877a85039d3985d96760ed844092319743fb3a76712d9b5e8a1650666fdd3a9de7855b6da63ab629b1701f23738477e2325f7ca2150ac"} 2025-11-10T00:49:26.803Z DEBUG minersc/fees.go:480 pay_fees, got miner id successfully {"miner id": "c3227e496fdf3c9aa604f3470a2bbd1249f00142150bc067996cd0d6ffcd77ea", "round": 179693, "block": ""} 2025-11-10T00:49:26.803Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T00:49:26.803Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:hermes"} 2025-11-10T00:49:26.802Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "hardfork:Medea"} 2025-11-10T00:49:26.802Z INFO miner/m_handler.go:242 Reject VRFShare: VRF is complete for this round {"vrfs_round_num": 179693, "vrfs_sender_index": 0, "vrfs_round_num": 179693} 2025-11-10T00:49:26.802Z DEBUG chain/protocol_view_change.go:424 [mvc] nonce, set nonce in getCurrentSelfNonce {"nonce": 92490} 2025-11-10T00:49:26.802Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\u001c\ufffd\ufffd\u0011\u0017}\ufffd\ufffd\ufffdQ\ufffd\ufffd4\ufffd<\ufffd\ufffdT\ufffd\ufffdbһ5/6t\ufffdz\ufffd\ufffdV"} 2025-11-10T00:49:26.802Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "E|\u0013\ufffd\tJ\t\ufffdZ9΃\u000cݔ\u0000@x\ufffdS\ufffd!R\u0001\ufffdCt\ufffdP\u0011d\u0005"} 2025-11-10T00:49:26.802Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\u0012\u0001\ufffd\ufffd\ufffd\ufffd\ufffd]o\u0013?\ufffd\ufffd_\ufffd۾\ufffdS\u0010\ufffd#\ufffd&l\ufffd\r\n\ufffd\ufffd\u001d2"} 2025-11-10T00:49:26.802Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "\ufffd\ufffdv\ufffd\ufffdl\ufffdr\ufffd\ufffd\ufffdF\ufffd+\ufffd\u0017H{~\ufffd\ufffd\ufffdi\ufffdO\ufffd\u0000\ufffd\ufffd\ufffd\ufffd\ufffd"} 2025-11-10T00:49:26.801Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "<\ufffd>\ufffds\ufffd)z\ufffd\ufffd%|F\ufffd\u001a\ufffd3k\u00119\u0013\ufffdf\ufffd\ufffd\ufffd\ufffdݬ)\u0010u"} 2025-11-10T00:49:26.801Z DEBUG statecache/statecache.go:147 state cache get - key not found {"key": "n\ufffd\ufffdHLk\ufffd}\u0002