Unhandled error while initializating Soledad: WrongMacError
well, soledad thinks i have corrupted recovery document, i think.
i created account in bitmask 0.8.1, then quit, then start bundle 0.9RC1
a couple things:
- this is an unfortunate and catastrophic error, that will result in a user losing all their data. we should really try hard to not let this happen, but maybe it happened this time because of 0.8.1?
- these type of fatal errors really need to be peculated up to the user.
leap.soledad.client.secrets:bootstrap - Trying to fetch cryptographic secrets from shared recovery database... [2015-08-20 11:01:44] INFO - L#307 : leap.soledad.client.secrets:_get_or_gen_crypto_secrets - Found cryptographic secrets in shared recovery database. [2015-08-20 11:01:44] ERROR - L#397 : leap.bitmask.services.soledad.soledadbootstrapper:_try_soledad_init - Unhandled error while initializating Soledad: WrongMacError("Could not authenticate recovery document's contents.",) Traceback (most recent call last): File "/home/elijah/Downloads/Bitmask-linux32-0.9.0rc1/./apps/leap/bitmask/services/soledad/soledadbootstrapper.py", line 381, in _try_soledad_init syncable=syncable) File "/home/elijah/Downloads/Bitmask-linux32-0.9.0rc1/./lib/leap/soledad/client/api.py", line 199, in __init__ self._init_secrets() File "/home/elijah/Downloads/Bitmask-linux32-0.9.0rc1/./lib/leap/soledad/client/api.py", line 242, in _init_secrets self._secrets.bootstrap() File "/home/elijah/Downloads/Bitmask-linux32-0.9.0rc1/./lib/leap/soledad/client/secrets.py", line 217, in bootstrap self._get_or_gen_crypto_secrets() File "/home/elijah/Downloads/Bitmask-linux32-0.9.0rc1/./lib/leap/soledad/client/secrets.py", line 309, in _get_or_gen_crypto_secrets _, mac, active_secret = self._import_recovery_document(doc.content) File "/home/elijah/Downloads/Bitmask-linux32-0.9.0rc1/./lib/leap/soledad/client/secrets.py", line 454, in _import_recovery_document raise crypto.WrongMacError('Could not authenticate recovery document\'s ' WrongMacError: Could not authenticate recovery document's contents. [2015-08-20 11:01:44] WARNING - L#252 : leap.bitmask.services.soledad.soledadbootstrapper:_do_soledad_init - Init failed, retrying... (retry 2 of 10) [2015-08-20 11:01:44] DEBUG - L#242 : leap.bitmask.services.soledad.soledadbootstrapper:_do_soledad_init - Trying to init soledad.... [2015-08-20 11:01:44] INFO - L#249 : leap.soledad.client.secrets:_has_secret - Checking if there's a secret in local storage... [2015-08-20 11:01:44] INFO - L#262 : leap.soledad.client.secrets:_has_secret - Could not find a secret in local storage. [2015-08-20 11:01:44] INFO - L#203 : leap.soledad.client.secrets:bootstrap - Trying to fetch cryptographic secrets from shared recovery database... [2015-08-20 11:01:45] WARNING - L#388 : leap.bitmask.services.soledad.soledadbootstrapper:_try_soledad_init - Error while initializing Soledad [2015-08-20 11:01:45] WARNING - L#252 : leap.bitmask.services.soledad.soledadbootstrapper:_do_soledad_init - Init failed, retrying... (retry 3 of 10) [2015-08-20 11:01:45] DEBUG - L#242 : leap.bitmask.services.soledad.soledadbootstrapper:_do_soledad_init - Trying to init soledad.... [2015-08-20 11:01:45] INFO - L#249 : leap.soledad.client.secrets:_has_secret - Checking if there's a secret in local storage... [2015-08-20 11:01:45] INFO - L#262 : leap.soledad.client.secrets:_has_secret - Could not find a secret in local storage. [2015-08-20 11:01:45] INFO - L#203 : leap.soledad.client.secrets:bootstrap - Trying to fetch cryptographic secrets from shared recovery database... [2015-08-20 11:01:46] WARNING - L#388 : leap.bitmask.services.soledad.soledadbootstrapper:_try_soledad_init - Error while initializing Soledad [2015-08-20 11:01:46] WARNING - L#252 : leap.bitmask.services.soledad.soledadbootstrapper:_do_soledad_init - Init failed, retrying... (retry 4 of 10) [2015-08-20 11:01:46] DEBUG - L#242 : leap.bitmask.services.soledad.soledadbootstrapper:_do_soledad_init - Trying to init soledad.... [2015-08-20 11:01:46] INFO - L#249 : leap.soledad.client.secrets:_has_secret - Checking if there's a secret in local storage... [2015-08-20 11:01:46] INFO - L#262 : leap.soledad.client.secrets:_has_secret - Could not find a secret in local storage. [2015-08-20 11:01:46] INFO - L#203 : leap.soledad.client.secrets:bootstrap - Trying to fetch cryptographic secrets from shared recovery database... [2015-08-20 11:01:47] WARNING - L#388 : leap.bitmask.services.soledad.soledadbootstrapper:_try_soledad_init - Error while initializing Soledad [2015-08-20 11:01:47] WARNING - L#252 : leap.bitmask.services.soledad.soledadbootstrapper:_do_soledad_init - Init failed, retrying... (retry 5 of 10) [2015-08-20 11:01:47] DEBUG - L#242 : leap.bitmask.services.soledad.soledadbootstrapper:_do_soledad_init - Trying to init soledad.... [2015-08-20 11:01:47] INFO - L#249 : leap.soledad.client.secrets:_has_secret - Checking if there's a secret in local storage... [2015-08-20 11:01:47] INFO - L#262 : leap.soledad.client.secrets:_has_secret - Could not find a secret in local storage. [2015-08-20 11:01:47] INFO - L#203 : leap.soledad.client.secrets:bootstrap - Trying to fetch cryptographic secrets from shared recovery database... [2015-08-20 11:01:47] WARNING - L#388 : leap.bitmask.services.soledad.soledadbootstrapper:_try_soledad_init - Error while initializing Soledad [2015-08-20 11:01:47] WARNING - L#252 : leap.bitmask.services.soledad.soledadbootstrapper:_do_soledad_init - Init failed, retrying... (retry 6 of 10) [2015-08-20 11:01:47] DEBUG - L#242 : leap.bitmask.services.soledad.soledadbootstrapper:_do_soledad_init - Trying to init soledad.... [2015-08-20 11:01:47] INFO - L#249 : leap.soledad.client.secrets:_has_secret - Checking if there's a secret in local storage... [2015-08-20 11:01:47] INFO - L#262 : leap.soledad.client.secrets:_has_secret - Could not find a secret in local storage. [2015-08-20 11:01:47] INFO - L#203 : leap.soledad.client.secrets:bootstrap - Trying to fetch cryptographic secrets from shared recovery database... [2015-08-20 11:01:48] WARNING - L#388 : leap.bitmask.services.soledad.soledadbootstrapper:_try_soledad_init - Error while initializing Soledad [2015-08-20 11:01:48] WARNING - L#252 : leap.bitmask.services.soledad.soledadbootstrapper:_do_soledad_init - Init failed, retrying... (retry 7 of 10) [2015-08-20 11:01:48] DEBUG - L#242 : leap.bitmask.services.soledad.soledadbootstrapper:_do_soledad_init - Trying to init soledad.... [2015-08-20 11:01:48] INFO - L#249 : leap.soledad.client.secrets:_has_secret - Checking if there's a secret in local storage... [2015-08-20 11:01:48] INFO - L#262 : leap.soledad.client.secrets:_has_secret - Could not find a secret in local storage. [2015-08-20 11:01:48] INFO - L#203 : leap.soledad.client.secrets:bootstrap - Trying to fetch cryptographic secrets from shared recovery database... [2015-08-20 11:01:49] WARNING - L#388 : leap.bitmask.services.soledad.soledadbootstrapper:_try_soledad_init - Error while initializing Soledad [2015-08-20 11:01:49] WARNING - L#252 : leap.bitmask.services.soledad.soledadbootstrapper:_do_soledad_init - Init failed, retrying... (retry 8 of 10) [2015-08-20 11:01:49] DEBUG - L#242 : leap.bitmask.services.soledad.soledadbootstrapper:_do_soledad_init - Trying to init soledad.... [2015-08-20 11:01:49] INFO - L#249 : leap.soledad.client.secrets:_has_secret - Checking if there's a secret in local storage... [2015-08-20 11:01:49] INFO - L#262 : leap.soledad.client.secrets:_has_secret - Could not find a secret in local storage. [2015-08-20 11:01:49] INFO - L#203 : leap.soledad.client.secrets:bootstrap - Trying to fetch cryptographic secrets from shared recovery database... [2015-08-20 11:01:50] WARNING - L#388 : leap.bitmask.services.soledad.soledadbootstrapper:_try_soledad_init - Error while initializing Soledad [2015-08-20 11:01:50] WARNING - L#252 : leap.bitmask.services.soledad.soledadbootstrapper:_do_soledad_init - Init failed, retrying... (retry 9 of 10) [2015-08-20 11:01:50] DEBUG - L#242 : leap.bitmask.services.soledad.soledadbootstrapper:_do_soledad_init - Trying to init soledad.... [2015-08-20 11:01:50] INFO - L#249 : leap.soledad.client.secrets:_has_secret - Checking if there's a secret in local storage... [2015-08-20 11:01:50] INFO - L#262 : leap.soledad.client.secrets:_has_secret - Could not find a secret in local storage. [2015-08-20 11:01:50] INFO - L#203 : leap.soledad.client.secrets:bootstrap - Trying to fetch cryptographic secrets from shared recovery database... [2015-08-20 11:01:50] WARNING - L#388 : leap.bitmask.services.soledad.soledadbootstrapper:_try_soledad_init - Error while initializing Soledad [2015-08-20 11:01:50] WARNING - L#252 : leap.bitmask.services.soledad.soledadbootstrapper:_do_soledad_init - Init failed, retrying... (retry 10 of 10) [2015-08-20 11:01:50] DEBUG - L#242 : leap.bitmask.services.soledad.soledadbootstrapper:_do_soledad_init - Trying to init soledad.... [2015-08-20 11:01:50] INFO - L#249 : leap.soledad.client.secrets:_has_secret - Checking if there's a secret in local storage... [2015-08-20 11:01:50] INFO - L#262 : leap.soledad.client.secrets:_has_secret - Could not find a secret in local storage. [2015-08-20 11:01:50] INFO - L#203 : leap.soledad.client.secrets:bootstrap - Trying to fetch cryptographic secrets from shared recovery database... [2015-08-20 11:01:51] WARNING - L#388 : leap.bitmask.services.soledad.soledadbootstrapper:_try_soledad_init - Error while initializing Soledad [2015-08-20 11:01:51] WARNING - L#252 : leap.bitmask.services.soledad.soledadbootstrapper:_do_soledad_init - Init failed, retrying... (retry 11 of 10) [2015-08-20 11:01:51] ERROR - L#255 : leap.bitmask.services.soledad.soledadbootstrapper:_do_soledad_init - Database is already locked. Traceback (most recent call last): File "/home/elijah/Downloads/Bitmask-linux32-0.9.0rc1/./apps/leap/bitmask/services/soledad/soledadbootstrapper.py", line 245, in _do_soledad_init server_url, cert_file, token, syncable) File "/home/elijah/Downloads/Bitmask-linux32-0.9.0rc1/./apps/leap/bitmask/services/soledad/soledadbootstrapper.py", line 381, in _try_soledad_init syncable=syncable) File "/home/elijah/Downloads/Bitmask-linux32-0.9.0rc1/./lib/leap/soledad/client/api.py", line 199, in __init__ self._init_secrets() File "/home/elijah/Downloads/Bitmask-linux32-0.9.0rc1/./lib/leap/soledad/client/api.py", line 242, in _init_secrets self._secrets.bootstrap() File "/home/elijah/Downloads/Bitmask-linux32-0.9.0rc1/./lib/leap/soledad/client/secrets.py", line 213, in bootstrap raise BootstrapSequenceError('Database is already locked.') BootstrapSequenceError: Database is already locked.
(from redmine: created on 2015-08-20, relates #7472 (closed))