[mirror-net] RC changed without triggering an op, noticed on block x + other nuances related to start of the mirror
RC changed without triggering an op, noticed on block x, where x is a first block after starting a replayed, converted block_log for the mirror net.
In my case there was a block_log converted up to 66000000, so it happened at 66000001:
2022-07-28T17:54:53.929444 witness_plugin.cpp:560 plugin_startup ] Launching block production for 26 witnesses.
2022-07-28T17:54:53.929952 witness_plugin.cpp:571 plugin_startup ] witness plugin: plugin_startup() end
2022-07-28T17:54:53.929974 state_snapshot_plugin.cpp:1466 plugin_startup ] Starting up state_snapshot_plugin...
2022-07-28T17:54:53.929983 wallet_bridge_api_plugin.cpp:20 plugin_startup ] Wallet bridge api plugin initialization...
2022-07-28T17:54:53.929998 wallet_bridge_api.cpp:169 api_startup ] Wallet bridge api initialized. Missing plugins: account_history_api account_by_key_api market_history_api
Entering application main loop...
2022-07-28T17:54:54.014107 p2p_plugin.cpp:570 broadcast_block ] Broadcasting block #66000001 with 0 transactions
2022-07-28T17:54:54.492703 rc_plugin.cpp:609 regenerate ] NOTIFYALERT! Account dleas max RC changed from 64745506631 to 59369548456 without triggering an op, noticed on block 66000001
2022-07-28T17:54:54.492983 rc_plugin.cpp:609 regenerate ] NOTIFYALERT! Account hbdstabiliser max RC changed from 63604303839 to 58766088694 without triggering an op, noticed on block 66000001
2022-07-28T17:54:54.493193 rc_plugin.cpp:609 regenerate ] NOTIFYALERT! Account kyrptogamers max RC changed from 43911099119 to 37557326629 without triggering an op, noticed on block 66000001
(...)
2022-07-28T17:55:13.851408 rc_plugin.cpp:609 regenerate ] NOTIFYALERT! Account mike29 max RC changed from 9849441432 to 9066572185 without triggering an op, noticed on block 66000001
2022-07-28T17:55:13.851612 rc_plugin.cpp:609 regenerate ] NOTIFYALERT! Account onelovedtube max RC changed from 956640451724 to 919267355523 without triggering an op, noticed on block 66000001
2022-07-28T17:55:13.851942 rc_plugin.cpp:609 regenerate ] NOTIFYALERT! Account daywin max RC changed from 2360979805 to 2312503094 without triggering an op, noticed on block 66000001
2022-07-28T17:55:14.115657 database.cpp:7002 remove_expired_gover ] Threshold exceeded while processing account lion200 with expired governance vote.
2022-07-28T17:55:14.117791 database.cpp:4124 check_free_memory ] Free memory is now 12G. Current block number: 66000001
2022-07-28T17:55:14.117818 witness_plugin.cpp:359 block_production_loo ] Generated block #66000001 with timestamp 2022-07-28T17:54:54 at time 2022-07-28T17:54:54
2022-07-28T17:55:14.117980 block_flow_control.cpp:41 log_stats ] Block stats:{"num":66000001,"type":"new","id":"03ef1481bd8f1f34df6af8e40fcd68a0584dbb4b","ts":"2022-07-28T17:54:54","bp":"deathwing","txs":0,"size":135,"offset":14193,"before":{"inc":0,"ok":0},"after":{
"exp":0,"fail":0,"appl":0,"post":0},"exec":{"offset":83,"pre":35,"work":14075,"post":20103750,"all":20117860}}
2022-07-28T17:55:14.118003 chain_plugin.cpp:438 operator() ] entering live mode
2022-07-28T17:55:14.600943 p2p_plugin.cpp:570 broadcast_block ] Broadcasting block #66000002 with 0 transactions
2022-07-28T17:55:14.601372 rc_plugin.cpp:609 regenerate ] NOTIFYALERT! Account steempeak max RC changed from 45483337198863 to 42285375029736 without triggering an op, noticed on block 66000002
2022-07-28T17:55:14.673268 database.cpp:7002 remove_expired_gover ] Threshold exceeded while processing account thylax with expired governance vote.
2022-07-28T17:55:14.673352 block_flow_control.cpp:41 log_stats ] Block stats:{"num":66000002,"type":"new","id":"03ef14822bf2625076b5d8cb9522bc9a5c249bd9","ts":"2022-07-28T17:55:15","bp":"steempeak","txs":0,"size":135,"offset":-398920,"before":{"inc":0,"ok":0},"after"
:{"exp":0,"fail":0,"appl":0,"post":0},"exec":{"offset":-399597,"pre":60,"work":617,"post":72263,"all":72940}}
2022-07-28T17:55:14.673480 witness_plugin.cpp:359 block_production_loo ] Generated block #66000002 with timestamp 2022-07-28T17:55:15 at time 2022-07-28T17:55:15
2022-07-28T17:55:17.601031 p2p_plugin.cpp:570 broadcast_block ] Broadcasting block #66000003 with 0 transactions
2022-07-28T17:55:17.650327 database.cpp:7002 remove_expired_gover ] Threshold exceeded while processing account nuribel with expired governance vote.
2022-07-28T17:55:17.650398 block_flow_control.cpp:41 log_stats ] Block stats:{"num":66000003,"type":"new","id":"03ef14834499ed58690ee279c4b0f456056af030","ts":"2022-07-28T17:55:18","bp":"themarkymark","txs":0,"size":138,"offset":-398836,"before":{"inc":0,"ok":0},"aft
er":{"exp":0,"fail":0,"appl":0,"post":0},"exec":{"offset":-399508,"pre":57,"work":615,"post":49226,"all":49898}}
2022-07-28T17:55:17.650524 witness_plugin.cpp:359 block_production_loo ] Generated block #66000003 with timestamp 2022-07-28T17:55:18 at time 2022-07-28T17:55:18
So few things here:
-
there's a plenty of those RC changes notifications, noticed on block 66000001, those are displayed after
Broadcasting block #66000001 with 0 transactions
line
1a. there's another onenoticed on block 66000002
, I thought before that it's related to a gap between conversion, and start of a mirror (i.e. gap in time between 66000000 and 66000001) and related vops 1b. there's also one noticed on block 66000018, and then from time to time in later blocks (0 transactions because no incoming transactions at that instance) 1c. there were total of 1197 notifications noticed on block 66000001 -
why
entering live mode
is after generating 66000001? -
multiple occurrences of
Threshold exceeded while processing account xxx with expired governance vote.