invalid token after logging in
Using:
- leap platform in cdev: dc9d440a207abacc7f54ee0065574cb27004c2eb (current master)
- bitmask-dev: 23fc0e42 (current master)
How to reproduce:
$ bitmaskctl start $ bitmaskctl user auth drebs@cdev.bitmask.net Password: srp_token wpic0tuhDoGp8BwwbXo1FrN8XAjlQbqjO4OEB5Wy5Ko uuid e49e5a920e52375229b4bb359d1e78e9
2016-10-10 10:47:55-0300 [-] Loading /home/drebs/dev/leap/repos/bitmask-dev/src/leap/bitmask/core/bitmaskd.tac... 2016-10-10 10:47:55-0300 [-] Loaded. 2016-10-10 10:47:55-0300 [-] twistd 16.3.0 (/home/drebs/.venv/bin/python2 2.7.9) starting up. 2016-10-10 10:47:55-0300 [-] reactor class: twisted.internet.epollreactor.EPollReactor. 2016-10-10 10:47:55-0300 [-] starting Bonafide Service 2016-10-10 10:47:55-0300 [-] registering hook on_passphrase_entry->soledad 2016-10-10 10:47:55-0300 [-] registering hook on_bonafide_auth->soledad 2016-10-10 10:47:55-0300 [-] registering hook on_passphrase_change->soledad 2016-10-10 10:47:55-0300 [-] registering hook on_bonafide_auth->keymanager 2016-10-10 10:47:55-0300 [-] registering hook on_bonafide_auth->mail 2016-10-10 10:47:55-0300 [-] registering hook on_bonafide_logout->mail 2016-10-10 10:47:55-0300 [-] initializing service: soledad 2016-10-10 10:47:55-0300 [-] starting Soledad Service 2016-10-10 10:47:55-0300 [-] registering hook on_new_soledad_instance->keymanager 2016-10-10 10:47:55-0300 [-] initializing service: keymanager 2016-10-10 10:47:55-0300 [-] starting Keymanager Service 2016-10-10 10:47:55-0300 [-] registering hook on_new_keymanager_instance->mail 2016-10-10 10:47:55-0300 [-] initializing service: mail 2016-10-10 10:47:55-0300 [-] starting mail service 2016-10-10 10:47:55-0300 [-] starting imap service 2016-10-10 10:47:55-0300 [-] LeapIMAPFactory starting on 1984 2016-10-10 10:47:55-0300 [-] Starting factory 2016-10-10 10:47:55-0300 [-] IMAP4 Server is RUNNING in port 1984 2016-10-10 10:47:55-0300 [-] starting smtp service 2016-10-10 10:47:55-0300 [-] SMTPFactory starting on 2013 2016-10-10 10:47:55-0300 [-] Starting factory 2016-10-10 10:47:55-0300 [-] starting incoming mail service 2016-10-10 10:47:55-0300 [-] starting ZMQ dispatcher 2016-10-10 10:47:55-0300 [-] initializing service: web 2016-10-10 10:47:55-0300 [-] webdir: /home/drebs/.venv/lib/python2.7/site-packages/leap/bitmask_js/public 2016-10-10 10:47:55-0300 [-] Site starting on 7070 2016-10-10 10:47:55-0300 [-] Starting factory 2016-10-10 10:48:13-0300 [-] provider already initialized 2016-10-10 10:48:13-0300 [-] on_passphrase_entry: New Soledad Instance: drebs@cdev.bitmask.net 2016-10-10 10:48:13-0300 [-] trying to load secrets from local storage... 2016-10-10 10:48:14-0300 [-] found secrets in local storage 2016-10-10 10:48:14-0300 [-] starting the encryption loop... 2016-10-10 10:48:14-0300 [-] sqlcipher: setting write-ahead logging 2016-10-10 10:48:14-0300 [-] sqlcipher: setting synchronous normal 2016-10-10 10:48:14-0300 [-] SQLCipher backend: closing 2016-10-10 10:48:14-0300 [-] Adding a new Keymanager instance for drebs@cdev.bitmask.net 2016-10-10 10:48:14-0300 [-] adding Keymanager instance for: drebs@cdev.bitmask.net 2016-10-10 10:48:14-0300 [-] sqlcipher: setting write-ahead logging 2016-10-10 10:48:14-0300 [-] sqlcipher: setting synchronous normal 2016-10-10 10:48:14-0300 [-] checking if soledad has ever synced... 2016-10-10 10:48:14-0300 [-] sqlcipher: setting write-ahead logging 2016-10-10 10:48:14-0300 [-] provider already initialized 2016-10-10 10:48:14-0300 [-] AUTH for drebs@cdev.bitmask.net 2016-10-10 10:48:14-0300 [-] POST to https://api.cdev.bitmask.net:4430/1/sessions 2016-10-10 10:48:14-0300 [-] sqlcipher: setting synchronous normal 2016-10-10 10:48:14-0300 [-] Starting factory 2016-10-10 10:48:14-0300 [-] sqlcipher: setting write-ahead logging 2016-10-10 10:48:14-0300 [-] soledad has synced in the past 2016-10-10 10:48:14-0300 [-] looking up private key for drebs@cdev.bitmask.net 2016-10-10 10:48:14-0300 [-] getting key for drebs@cdev.bitmask.net 2016-10-10 10:48:14-0300 [-] sqlcipher: setting synchronous normal 2016-10-10 10:48:14-0300 [-] found key: 2016-10-10 10:48:14-0300 [-] setting up incoming mail service for drebs@cdev.bitmask.net 2016-10-10 10:48:14-0300 [-] Mail post-sync hook: processing queued docs 2016-10-10 10:48:14-0300 [-] setting incoming mail service for drebs@cdev.bitmask.net 2016-10-10 10:48:14-0300 [-] fetching mail for: b2a386cd8f06dc89a0e13863895fb328 drebs@cdev.bitmask.net 2016-10-10 10:48:14-0300 [-] starting sync... 2016-10-10 10:48:14-0300 [-] sync finished 2016-10-10 10:48:14-0300 [-] processing doclist 2016-10-10 10:48:14-0300 [-] no docs found 2016-10-10 10:48:20-0300 [-] PUT to https://api.cdev.bitmask.net:4430/1/sessions/drebs 2016-10-10 10:48:20-0300 [-] Starting factory 2016-10-10 10:48:20-0300 [-] Stopping factory 2016-10-10 10:48:21-0300 [-] provider already initialized 2016-10-10 10:48:21-0300 [-] passing a new SRP Token to Soledad: drebs@cdev.bitmask.net 2016-10-10 10:48:21-0300 [-] sqlcipher: setting write-ahead logging 2016-10-10 10:48:22-0300 [-] sqlcipher: setting synchronous normal 2016-10-10 10:48:22-0300 [-] provider already initialized 2016-10-10 10:48:22-0300 [-] passing a new SRP Token to Keymanager: drebs@cdev.bitmask.net 2016-10-10 10:48:22-0300 [-] looking for incoming mail service for auth: drebs@cdev.bitmask.net 2016-10-10 10:48:22-0300 [-] Stopping factory 2016-10-10 10:49:14-0300 [-] fetching mail for: b2a386cd8f06dc89a0e13863895fb328 drebs@cdev.bitmask.net 2016-10-10 10:49:14-0300 [-] starting sync... 2016-10-10 10:49:14-0300 [-] Starting factory 2016-10-10 10:49:19-0300 [-] got exception when syncing! *--- Failure #13 --- Failure: leap.soledad.common.errors.InvalidAuthTokenError: *--- End of Failure #13 --- 2016-10-10 10:49:19-0300 [-] sync failed because token is invalid: 2016-10-10 10:49:19-0300 [-] processing doclist 2016-10-10 10:49:19-0300 [-] no docs found
(from redmine: created on 2016-10-10, closed on 2016-11-01)