3856
General Discussion / Re: October 5 Test Network
« on: October 08, 2015, 09:41:12 pm »Running with latest commit (e68e99ed3ae11ddac607e983e7549e8278fdecc4), but it can't go over block 70872Every day so many witnesses are not online, what is the reason?
We've identified an issue where the assignment of new object ID's is inconsistent (we use a hashed index with an undefined iteration order). Fortunately the testnet's main fork has them in increasing order (I suspect it has to do with the memory allocator tending to put things allocated later at higher addresses), in the next hardfork this condition will be enforced (by replacing most of our hashed indexes with ordered indexes). We suspect some witnesses are getting their state wrong when they assign an ID differently from the main network, if someone publishes a transaction using that ID then the wrong state turns into a desync (they'll no longer sign or pay attention to blocks on the main fork because they think the main fork has an illegal transaction.)
If you get stuck and the first error message mentions a vesting balance object, this is almost certainly what's happening to you.
The next hardfork will fix this issue, and in addition, I'm working on a tool to help us find if there are any similar issues.
The transactions being executed by the community testers have been incredibly helpful to us.
Code: [Select]
2015-10-08T21:37:17 p2p:send_sync_block_to_node_delegate send_sync_block_to_n ] Failed to push sync block 70872 (id:000114d879ab3c305edeaaae837c2b68b7da64d2): client rejected sync block sent by peer: {"code":10,"name":"assert_exception","message":"Assert Exception","stack":[{"context":{"level":"error","file":"vesting_balance_evaluator.cpp","line":103,"method":"do_evaluate","hostname":"","thread_name":"th_a","timestamp":"2015-10-08T21:37:17"},"format":"vbo.is_withdraw_allowed( now, op.amount ): ","data":{"now":"2015-10-08T05:43:09","op":{"fee":{"amount":100000,"asset_id":"1.3.0"},"vesting_balance":"1.13.60","owner":"1.2.8517","amount":{"amount":45300000,"asset_id":"1.3.0"}},"vbo":{"id":"1.13.60","owner":"1.2.8517","balance":{"amount":197500000,"asset_id":"1.3.0"},"policy":[1,{"vesting_seconds":86400,"start_claim":"1970-01-01T00:00:00","coin_seconds_earned":"3341610000000","coin_seconds_earned_last_update":"2015-10-08T05:43:06"}]}}},{"context":{"level":"warn","file":"vesting_balance_evaluator.cpp","line":109,"method":"do_evaluate","hostname":"","thread_name":"th_a","timestamp":"2015-10-08T21:37:17"},"format":"","data":{"op":{"fee":{"amount":100000,"asset_id":"1.3.0"},"vesting_balance":"1.13.60","owner":"1.2.8517","amount":{"amount":45300000,"asset_id":"1.3.0"}}}},{"context":{"level":"warn","file":"evaluator.cpp","line":42,"method":"start_evaluate","hostname":"","thread_name":"th_a","timestamp":"2015-10-08T21:37:17"},"format":"","data":{}},{"context":{"level":"warn","file":"db_block.cpp","line":628,"method":"apply_operation","hostname":"","thread_name":"th_a","timestamp":"2015-10-08T21:37:17"},"format":"","data":{}},{"context":{"level":"warn","file":"db_block.cpp","line":611,"method":"_apply_transaction","hostname":"","thread_name":"th_a","timestamp":"2015-10-08T21:37:17"},"format":"","data":{"trx":{"ref_block_num":5335,"ref_block_prefix":4159425851,"expiration":"2015-10-08T05:43:39","operations":[[33,{"fee":{"amount":100000,"asset_id":"1.3.0"},"vesting_balance":"1.13.60","owner":"1.2.8517","amount":{"amount":45300000,"asset_id":"1.3.0"}}]],"extensions":[],"signatures":["1f6f7ea6a4188c8fc36aaf457b5fe4433fb74af11b250507262a00d909af025ad065c03ef0f61925070489d1630a3fbe459795b265200544de9ba1694414fefbcf"]}}},{"context":{"level":"warn","file":"db_block.cpp","line":514,"method":"_apply_block","hostname":"","thread_name":"th_a","timestamp":"2015-10-08T21:37:17"},"format":"","data":{"next_block.block_num()":70872}},{"context":{"level":"warn","file":"db_block.cpp","line":197,"method":"_push_block","hostname":"","thread_name":"th_a","timestamp":"2015-10-08T21:37:17"},"format":"","data":{"new_block":{"previous":"000114d73bcdebf717450d1a45e7ea119844b22e","timestamp":"2015-10-08T05:43:15","witness":"1.6.10","transaction_merkle_root":"05b459df123ff6baf5dbc44890e6ae3e8a8caaf6","extensions":[],"witness_signature":"20232fc2bb2ead0cbc644d78e4462881dc812787ad28f1517229cc346c252acb2904cb13139a8e957c8087d8b03790f12f5c2ef0dbb2cfceead7a47521f75f0950","transactions":[{"ref_block_num":5335,"ref_block_prefix":4159425851,"expiration":"2015-10-08T05:43:39","operations":[[33,{"fee":{"amount":100000,"asset_id":"1.3.0"},"vesting_balance":"1.13.60","owner":"1.2.8517","amount":{"amount":45300000,"asset_id":"1.3.0"}}]],"extensions":[],"signatures":["1f6f7ea6a4188c8fc36aaf457b5fe4433fb74af11b250507262a00d909af025ad065c03ef0f61925070489d1630a3fbe459795b265200544de9ba1694414fefbcf"],"operation_results":[[0,{}]]}]}}},{"context":{"level":"warn","file":"application.cpp","line":441,"method":"handle_block","hostname":"","thread_name":"th_a","timestamp":"2015-10-08T21:37:17"},"format":"","data":{"blk_msg":{"block":{"previous":"000114d73bcdebf717450d1a45e7ea119844b22e","timestamp":"2015-10-08T05:43:15","witness":"1.6.10","transaction_merkle_root":"05b459df123ff6baf5dbc44890e6ae3e8a8caaf6","extensions":[],"witness_signature":"20232fc2bb2ead0cbc644d78e4462881dc812787ad28f1517229cc346c252acb2904cb13139a8e957c8087d8b03790f12f5c2ef0dbb2cfceead7a47521f75f0950","transactions":[{"ref_block_num":5335,"ref_block_prefix":4159425851,"expiration":"2015-10-08T05:43:39","operations":[[33,{"fee":{"amount":100000,"asset_id":"1.3.0"},"vesting_balance":"1.13.60","owner":"1.2.8517","amount":{"amount":45300000,"asset_id":"1.3.0"}}]],"extensions":[],"signatures":["1f6f7ea6a4188c8fc36aaf457b5fe4433fb74af11b250507262a00d909af025ad065c03ef0f61925070489d1630a3fbe459795b265200544de9ba1694414fefbcf"],"operation_results":[[0,{}]]}]},"block_id":"000114d879ab3c305edeaaae837c2b68b7da64d2"},"sync_mode":true}}]} node.cpp:3043
2015-10-08T21:37:17 p2p:send_sync_block_to_node_delegate send_sync_block_to_n ] disconnecting client 104.236.51.238:2005 because it offered us the rejected block node.cpp:3157