dtr-org / unit-e

A digital currency for a new era of decentralized trust
https://unit-e.io
MIT License
45 stars 15 forks source link

feature_reindex_commits functional tests floating #930

Closed scravy closed 5 years ago

scravy commented 5 years ago

feature_reindex_commits seems to be floating and is flaking out every now and then.

feature_reindex_commits.py failed, Duration: 100 s

stdout:
2019-04-10 00:50:59.760000 TestFramework (INFO): Initializing test directory /tmp/unite_test_runner_20190410_024145/feature_reindex_commits_676
2019-04-10 00:50:59.760000 TestFramework (INFO): Debug file at /tmp/unite_test_runner_20190410_024145/feature_reindex_commits_676/node0/regtest/debug.log
Starting node 0 with args: -proposing=1 -esperanzaconfig={"epochLength": 10, "minDepositSize": 1500, "dynastyLogoutDelay": 2, "withdrawalEpochDelay": 2}
Starting node 1 with args: -validating=1 -esperanzaconfig={"epochLength": 10, "minDepositSize": 1500, "dynastyLogoutDelay": 2, "withdrawalEpochDelay": 2}
2019-04-10 00:50:59.760000 TestFramework.node0 (INFO): Running command: /home/scravy/Github/scravy/unit-e/src/unit-e -datadir=/tmp/unite_test_runner_20190410_024145/feature_reindex_commits_676/node0 -server -keypool=1 -discover=0 -rest -logtimemicros -debug -debugexclude=libevent -debugexclude=leveldb -mocktime=0 -uacomment=testnode0 -proposing=1 -esperanzaconfig={"epochLength": 10, "minDepositSize": 1500, "dynastyLogoutDelay": 2, "withdrawalEpochDelay": 2}
2019-04-10 00:50:59.761000 TestFramework.node1 (INFO): Running command: /home/scravy/Github/scravy/unit-e/src/unit-e -datadir=/tmp/unite_test_runner_20190410_024145/feature_reindex_commits_676/node1 -server -keypool=1 -discover=0 -rest -logtimemicros -debug -debugexclude=libevent -debugexclude=leveldb -mocktime=0 -uacomment=testnode1 -validating=1 -esperanzaconfig={"epochLength": 10, "minDepositSize": 1500, "dynastyLogoutDelay": 2, "withdrawalEpochDelay": 2}
2019-04-10 00:51:07.856000 TestFramework.node0 (INFO): Running command: /home/scravy/Github/scravy/unit-e/src/unit-e -datadir=/tmp/unite_test_runner_20190410_024145/feature_reindex_commits_676/node0 -server -keypool=1 -discover=0 -rest -logtimemicros -debug -debugexclude=libevent -debugexclude=leveldb -mocktime=0 -uacomment=testnode0 -proposing=1 -esperanzaconfig={"epochLength": 10, "minDepositSize": 1500, "dynastyLogoutDelay": 2, "withdrawalEpochDelay": 2} -reindex
2019-04-10 00:51:07.857000 TestFramework.node1 (INFO): Running command: /home/scravy/Github/scravy/unit-e/src/unit-e -datadir=/tmp/unite_test_runner_20190410_024145/feature_reindex_commits_676/node1 -server -keypool=1 -discover=0 -rest -logtimemicros -debug -debugexclude=libevent -debugexclude=leveldb -mocktime=0 -uacomment=testnode1 -validating=1 -esperanzaconfig={"epochLength": 10, "minDepositSize": 1500, "dynastyLogoutDelay": 2, "withdrawalEpochDelay": 2} -reindex
2019-04-10 00:51:19.200000 TestFramework.node0 (INFO): Running command: /home/scravy/Github/scravy/unit-e/src/unit-e -datadir=/tmp/unite_test_runner_20190410_024145/feature_reindex_commits_676/node0 -server -keypool=1 -discover=0 -rest -logtimemicros -debug -debugexclude=libevent -debugexclude=leveldb -mocktime=0 -uacomment=testnode0 -proposing=1 -esperanzaconfig={"epochLength": 10, "minDepositSize": 1500, "dynastyLogoutDelay": 2, "withdrawalEpochDelay": 2}
2019-04-10 00:51:19.203000 TestFramework.node1 (INFO): Running command: /home/scravy/Github/scravy/unit-e/src/unit-e -datadir=/tmp/unite_test_runner_20190410_024145/feature_reindex_commits_676/node1 -server -keypool=1 -discover=0 -rest -logtimemicros -debug -debugexclude=libevent -debugexclude=leveldb -mocktime=0 -uacomment=testnode1 -validating=1 -esperanzaconfig={"epochLength": 10, "minDepositSize": 1500, "dynastyLogoutDelay": 2, "withdrawalEpochDelay": 2}
2019-04-10 00:52:39.798000 TestFramework (ERROR): Assertion failed
Traceback (most recent call last):
  File "/home/scravy/Github/scravy/unit-e/test/functional/test_framework/test_framework.py", line 156, in main
    self.run_test()
  File "/home/scravy/Github/scravy/unit-e/test/functional/feature_reindex_commits.py", line 94, in run_test
    count=10)
  File "/home/scravy/Github/scravy/unit-e/test/functional/test_framework/test_framework.py", line 460, in generate_epoch
    cls.wait_for_vote_and_disconnect(finalizer, proposer)
  File "/home/scravy/Github/scravy/unit-e/test/functional/test_framework/test_framework.py", line 419, in wait_for_vote_and_disconnect
    sync_blocks([finalizer, node])
  File "/home/scravy/Github/scravy/unit-e/test/functional/test_framework/util.py", line 536, in sync_blocks
    maxheight, "".join("\n  {!r}".format(tip) for tip in tips)))
AssertionError: Block sync to height 291 timed out:
  {'hash': 'd7088e683e9ee6a71db0ebd438c5bcc919586b9b57355fdf1720cb065d94daf3', 'height': 299}
  {'hash': 'd7088e683e9ee6a71db0ebd438c5bcc919586b9b57355fdf1720cb065d94daf3', 'height': 299}
2019-04-10 00:52:39.799000 TestFramework (INFO): Stopping nodes
2019-04-10 00:52:40.252000 TestFramework (WARNING): Not cleaning up dir /tmp/unite_test_runner_20190410_024145/feature_reindex_commits_676
2019-04-10 00:52:40.252000 TestFramework (ERROR): Test failed. Test logging available at /tmp/unite_test_runner_20190410_024145/feature_reindex_commits_676/test_framework.log
2019-04-10 00:52:40.253000 TestFramework (ERROR): Hint: Call /home/scravy/Github/scravy/unit-e/test/functional/combine_logs.py '/tmp/unite_test_runner_20190410_024145/feature_reindex_commits_676' to consolidate all logs