cryptoadvance / cryptoadvance/specter-desktop

Specter fails to start due to a Python exception in JadeAPI

Open
#2,138 2 comments 0 reactions 0 assignees View on GitHub
Dominant language
Python
Stars
847
Forks
259
Avg merge
6d 18h
Merged PRs (30d)
2

Description

**Describe the bug**
Launching recent versions of Specter result in a crash due to a python exception. I'm seeing the issue on v1.4.5, but version 1.4.1 seems to run just fine on the exact same device / environment.

**To Reproduce**
Steps to reproduce the behavior:
1. Install Specter v.1.4.5
2. Launch Specter
3. Get Python Exception
4. Process exits

**Expected behavior**
I expect Specter to launch properly. Even if there is an issue specific to one HW wallet library, I wouldn't expect it to prevent Specter from starting.

**Screenshots**
If applicable, add screenshots to help explain your problem.

**Desktop (please complete the following information):**
- Where is your node running: MyNode
- Where is your specter running: MyNode (aarch64)
- Browser: Chrome
- Specter Version: 1.4.5

**Additional context**
Here's the log. The exception seems to be in the Jade library.

```
Feb 01 20:40:52 myNode systemd[1]: Started Specter.
Feb 01 20:40:54 myNode specter[29295]: [2023-02-01 20:40:54,988] INFO in server: Configuration: cryptoadvance.specter.config.ProductionConfig
Feb 01 20:40:54 myNode specter[29295]: [2023-02-01 20:40:54,989] INFO in server: SPECTER_DATA_FOLDER: /home/bitcoin/.specter
Feb 01 20:40:54 myNode specter[29295]: [2023-02-01 20:40:54,989] INFO in cli_server: CERT:/mnt/hdd/mynode/settings/specter/myNode.local.crt
Feb 01 20:40:55 myNode specter[29295]: [2023-02-01 20:40:55,004] INFO in specter_migrator: Initiated MigDataManager(/home/bitcoin/.specter/migration_data.json events:17 execs:3 )
Feb 01 20:40:55 myNode specter[29295]: [2023-02-01 20:40:55,008] INFO in specter_migrator: Collecting possible migrations ...
Feb 01 20:40:55 myNode specter[29295]: [2023-02-01 20:40:55,010] INFO in specter_migrator: Collecting possible migrations ...
Feb 01 20:40:55 myNode specter[29295]: [2023-02-01 20:40:55,011] INFO in specter_migrator: Collecting possible migrations ...
Feb 01 20:40:55 myNode specter[29295]: [2023-02-01 20:40:55,011] INFO in specter_migrator: No Migrations to execute!
Feb 01 20:40:55 myNode specter[29295]: [2023-02-01 20:40:55,012] INFO in server: Initializing LoginManager
Feb 01 20:40:55 myNode specter[29295]: [2023-02-01 20:40:55,012] INFO in server: Initializing Specter with data-folder /home/bitcoin/.specter
Feb 01 20:40:55 myNode specter[29295]: [2023-02-01 20:40:55,012] INFO in service_manager: ----> starting service discovery Static
Feb 01 20:40:55 myNode specter[29295]: [2023-02-01 20:40:55,016] INFO in reflection: Found class SwanService
Feb 01 20:40:55 myNode specter[29295]: [2023-02-01 20:40:55,022] INFO in reflection: Found class LiquidissuerService
Feb 01 20:40:55 myNode specter[29295]: [2023-02-01 20:40:55,025] INFO in reflection: Found class DevhelpService
Feb 01 20:40:55 myNode specter[29295]: [2023-02-01 20:40:55,027] INFO in reflection: Found class ExfundService
Feb 01 20:40:55 myNode specter[29295]: [2023-02-01 20:40:55,029] INFO in reflection: Found class FaucetService
Feb 01 20:40:55 myNode specter[29295]: [2023-02-01 20:40:55,031] INFO in reflection: Found class ElectrumService
Feb 01 20:40:55 myNode specter[29295]: [2023-02-01 20:40:55,753] INFO in reflection: Found class SpectrumService
Feb 01 20:40:55 myNode specter[29295]: [2023-02-01 20:40:55,753] INFO in service_manager: ----> skipping service discovery dynamic
Feb 01 20:40:55 myNode specter[29295]: [2023-02-01 20:40:55,753] INFO in service_manager: ----> starting service loading
Feb 01 20:40:55 myNode specter[29295]: [2023-02-01 20:40:55,754] INFO in service_manager: Service DevhelpService not activated due to devstatus ( prod > alpha )
Feb 01 20:40:55 myNode specter[29295]: [2023-02-01 20:40:55,754] INFO in service_manager: Loading Service LiquidissuerService from cryptoadvance.specterext.liquidissuer.service
Feb 01 20:40:55 myNode specter[29295]: [2023-02-01 20:40:55,756] INFO in service_manager: Loading Service-specific configuration from
Feb 01 20:40:55 myNode specter[29295]: [2023-02-01 20:40:55,760] INFO in service_manager: Loading Controller cryptoadvance.specterext.liquidissuer.controller
Feb 01 20:40:55 myNode specter[29295]: [2023-02-01 20:40:55,884] INFO in service_manager: Mounted to /svc/liquidissuer
Feb 01 20:40:55 myNode specter[29295]: [2023-02-01 20:40:55,885] INFO in service_manager: Service LiquidissuerService activated (prod)
Feb 01 20:40:55 myNode specter[29295]: [2023-02-01 20:40:55,885] INFO in service_manager: Service SpectrumService not activated due to devstatus ( prod > alpha )
Feb 01 20:40:55 myNode specter[29295]: [2023-02-01 20:40:55,885] INFO in service_manager: Loading Service ExfundService from cryptoadvance.specterext.exfund.service
Feb 01 20:40:55 myNode specter[29295]: [2023-02-01 20:40:55,887] INFO in service_manager: Loading Service-specific configuration from
Feb 01 20:40:55 myNode specter[29295]: [2023-02-01 20:40:55,888] INFO in service_manager: Loading Controller cryptoadvance.specterext.exfund.controller
Feb 01 20:40:55 myNode specter[29295]: [2023-02-01 20:40:55,897] INFO in service_manager: Mounted to /ext/exfund
Feb 01 20:40:55 myNode specter[29295]: [2023-02-01 20:40:55,897] INFO in service_manager: Service ExfundService activated (prod)
Feb 01 20:40:55 myNode specter[29295]: [2023-02-01 20:40:55,897] INFO in service_manager: Loading Service ElectrumService from cryptoadvance.specterext.electrum.service
Feb 01 20:40:55 myNode specter[29295]: [2023-02-01 20:40:55,898] WARNING in service_manager: Service electrum does not have a service Configuration! Skipping!
Feb 01 20:40:55 myNode specter[29295]: [2023-02-01 20:40:55,899] INFO in service_manager: Loading Controller cryptoadvance.specterext.electrum.controller
Feb 01 20:40:55 myNode specter[29295]: [2023-02-01 20:40:55,906] INFO in service_manager: Mounted to /svc/electrum
Feb 01 20:40:55 myNode specter[29295]: [2023-02-01 20:40:55,908] INFO in reflection: Found class Electrum
Feb 01 20:40:55 myNode specter[29295]: [2023-02-01 20:40:55,909] INFO in service_manager: Service ElectrumService activated (prod)
Feb 01 20:40:55 myNode specter[29295]: [2023-02-01 20:40:55,909] INFO in service_manager: Service FaucetService not activated due to devstatus ( prod > beta )
Feb 01 20:40:55 myNode specter[29295]: [2023-02-01 20:40:55,909] INFO in service_manager: Loading Service SwanService from cryptoadvance.specterext.swan.service
Feb 01 20:40:55 myNode specter[29295]: [2023-02-01 20:40:55,910] INFO in service_manager: Loading Service-specific configuration from
Feb 01 20:40:55 myNode specter[29295]: [2023-02-01 20:40:55,911] INFO in service_manager: Loading Controller cryptoadvance.specterext.swan.controller
Feb 01 20:40:55 myNode specter[29295]: [2023-02-01 20:40:55,939] INFO in service_manager: Mounted to /svc/swan
Feb 01 20:40:55 myNode specter[29295]: [2023-02-01 20:40:55,939] INFO in service_manager: Service SwanService activated (prod)
Feb 01 20:40:55 myNode specter[29295]: [2023-02-01 20:40:55,940] INFO in service_manager: ----> finished service loading
Feb 01 20:40:55 myNode specter[29295]: [2023-02-01 20:40:55,940] INFO in specter: Instantiate VersionChecker
Feb 01 20:40:55 myNode specter[29295]: [2023-02-01 20:40:55,945] INFO in specter: Instantiate ConfigManager
Feb 01 20:40:55 myNode specter[29295]: [2023-02-01 20:40:55,958] INFO in specter: Instantiate NodeManager with node alias: default.
Feb 01 20:40:56 myNode specter[29295]: [2023-02-01 20:40:56,051] INFO in version: version checker stopped.
Feb 01 20:40:56 myNode specter[29295]: [2023-02-01 20:40:56,051] INFO in version: version checked, install_type pip curr: 1.14.5 latest: 1.9.4 ==> upgrade: False
Feb 01 20:40:56 myNode specter[29295]: [2023-02-01 20:40:56,247] INFO in node_manager: Loaded Node
Feb 01 20:40:56 myNode specter[29295]: [2023-02-01 20:40:56,284] INFO in wallet_manager: Iterating over 0 wallet files in /home/bitcoin/.specter/wallets/main
Feb 01 20:40:56 myNode specter[29295]: [2023-02-01 20:40:56,284] INFO in wallet_manager: Using threads in updating the wallet manager.
Feb 01 20:40:56 myNode specter[29295]: [2023-02-01 20:40:56,285] INFO in wallet_manager: Started updating wallets with 0 wallets
Feb 01 20:40:56 myNode specter[29295]: [2023-02-01 20:40:56,286] INFO in wallet_manager: Updating wallet manager done. Result:
Feb 01 20:40:56 myNode specter[29295]: [2023-02-01 20:40:56,286] INFO in wallet_manager: * failed_load_wallets: []
Feb 01 20:40:56 myNode specter[29295]: [2023-02-01 20:40:56,286] INFO in wallet_manager: * loaded_wallets: 0
Feb 01 20:40:56 myNode specter[29295]: [2023-02-01 20:40:56,313] DEBUG in log: GETCONF __owningcontrollerprocess (runtime: 0.0006)
Feb 01 20:40:56 myNode specter[29295]: [2023-02-01 20:40:56,314] INFO in checker: Checker health Checking every 600 seconds now
Feb 01 20:40:56 myNode specter[29295]: [2023-02-01 20:40:56,319] INFO in checker: Checker health started with period 600
Feb 01 20:40:56 myNode specter[29295]: [2023-02-01 20:40:56,319] INFO in checker: Checker price Checking every 600 seconds now
Feb 01 20:40:56 myNode specter[29295]: [2023-02-01 20:40:56,320] INFO in specter: Instantiate ServiceEncryptedStorageManager
Feb 01 20:40:56 myNode specter[29295]: [2023-02-01 20:40:56,320] INFO in specter: Instantiate ServiceUnencryptedStorageManager
Feb 01 20:40:56 myNode specter[29295]: [2023-02-01 20:40:56,320] INFO in hwi_rpc: Initializing HWI...
Feb 01 20:40:56 myNode specter[29295]: [2023-02-01 20:40:56,364] INFO in wallet_manager: Iterating over 0 wallet files in /home/bitcoin/.specter/wallets/main
Feb 01 20:40:56 myNode specter[29295]: [2023-02-01 20:40:56,365] INFO in wallet_manager: Using threads in updating the wallet manager.
Feb 01 20:40:56 myNode specter[29295]: [2023-02-01 20:40:56,366] INFO in wallet_manager: Started updating wallets with 0 wallets
Feb 01 20:40:56 myNode specter[29295]: [2023-02-01 20:40:56,366] INFO in wallet_manager: Updating wallet manager done. Result:
Feb 01 20:40:56 myNode specter[29295]: [2023-02-01 20:40:56,366] INFO in wallet_manager: * failed_load_wallets: []
Feb 01 20:40:56 myNode specter[29295]: [2023-02-01 20:40:56,367] INFO in checker: Checker health executed within 0.048 seconds. This message won't show again until stopped and started.
Feb 01 20:40:56 myNode specter[29295]: [2023-02-01 20:40:56,367] INFO in wallet_manager: * loaded_wallets: 0
Feb 01 20:40:56 myNode specter[29295]: [2023-02-01 20:40:56,419] ERROR in jade: Exception causing JadeAPI context exit.
Feb 01 20:40:56 myNode specter[29295]: [2023-02-01 20:40:56,419] ERROR in jade:
Feb 01 20:40:56 myNode specter[29295]: [2023-02-01 20:40:56,419] ERROR in jade: read nothing, apparent EOF
Feb 01 20:40:56 myNode specter[29295]: File "/opt/mynode/specter/env/lib/python3.8/site-packages/cryptoadvance/specter/devices/hwi/jade.py", line 871, in enumerate
Feb 01 20:40:56 myNode specter[29295]: verinfo = jade.get_version_info()
Feb 01 20:40:56 myNode specter[29295]: File "/opt/mynode/specter/env/lib/python3.8/site-packages/cryptoadvance/specter/devices/hwi/jadepy/jade.py", line 182, in get_version_info
Feb 01 20:40:56 myNode specter[29295]: return self._jadeRpc("get_version_info")
Feb 01 20:40:56 myNode specter[29295]: File "/opt/mynode/specter/env/lib/python3.8/site-packages/cryptoadvance/specter/devices/hwi/jadepy/jade.py", line 153, in _jadeRpc
Feb 01 20:40:56 myNode specter[29295]: reply = self.jade.make_rpc_call(request, long_timeout)
Feb 01 20:40:56 myNode specter[29295]: File "/opt/mynode/specter/env/lib/python3.8/site-packages/cryptoadvance/specter/devices/hwi/jadepy/jade.py", line 695, in make_rpc_call
Feb 01 20:40:56 myNode specter[29295]: reply = self.read_response(long_timeout)
Feb 01 20:40:56 myNode specter[29295]: File "/opt/mynode/specter/env/lib/python3.8/site-packages/cryptoadvance/specter/devices/hwi/jadepy/jade.py", line 675, in read_response
Feb 01 20:40:56 myNode specter[29295]: return self.read_cbor_message()
Feb 01 20:40:56 myNode specter[29295]: File "/opt/mynode/specter/env/lib/python3.8/site-packages/cryptoadvance/specter/devices/hwi/jadepy/jade.py", line 644, in read_cbor_message
Feb 01 20:40:56 myNode specter[29295]: message = cbor.load(self)
Feb 01 20:40:56 myNode specter[29295]: [2023-02-01 20:40:56,421] WARNING in jade: Draining interface...
Feb 01 20:40:56 myNode specter[29295]: [2023-02-01 20:40:56,421] WARNING in jade:
Feb 01 20:40:56 myNode specter[29295]: Aborted!
Feb 01 20:40:56 myNode systemd[1]: specter.service: Main process exited, code=exited, status=1/FAILURE
Feb 01 20:40:56 myNode systemd[1]: specter.service: Failed with result 'exit-code'.
```

Contributor guide

Open the contributing guide

Assessment

This issue has not been assessed yet.

Get new issues in your inbox

A short digest of beginner-friendly GitHub issues.