search

Multibit-Legacy / multibit-hd

Deprecated Bitcoin Wallet
https://multibit.org/blog/2017/07/26/multibit-shutdown.html
Other
173 stars 114 forks source link

KeepKey start up on Windows 8 sometimes loses KeepKey connection - shows password screen #755

Closed jim618 closed 8 years ago

jim618 commented 8 years ago

I have been testing the KeepKey start up on the Windows test machine today.

Twice I saw it 'drop' the KeepKey at the point where you click the 'unlock'. In the log I saw

{"@timestamp":"2015-10-16T15:47:41.946+01:00","@version":1,"message":"Writing buffer to HID pipe...","logger_name":"org.multibit.hd.hardware.keepkey.wallets.v1.KeepKeyV1HidHardwareWallet","thread_name":"safe-fixed-message-events-0","level":"DEBUG","level_value":10000}
{"@timestamp":"2015-10-16T15:47:41.948+01:00","@version":1,"message":"Wizard panel name CREDENTIALS_REQUEST_CIPHER_KEY","logger_name":"org.multibit.hd.ui.views.wizards.AbstractHardwareWalletWizard","thread_name":"AWT-EventQueue-0","level":"DEBUG","level_value":10000}
{"@timestamp":"2015-10-16T15:47:41.949+01:00","@version":1,"message":"Wrote 64 bytes to USB pipe.","logger_name":"org.multibit.hd.hardware.keepkey.wallets.v1.KeepKeyV1HidHardwareWallet","thread_name":"safe-fixed-message-events-0","level":"DEBUG","level_value":10000}
{"@timestamp":"2015-10-16T15:47:41.949+01:00","@version":1,"message":"Discarded message event: 'BUTTON_REQUEST' (different device)","logger_name":"org.multibit.hd.hardware.core.fsm.HardwareWalletContext","thread_name":"safe-fixed-message-events-0","level":"DEBUG","level_value":10000}
{"@timestamp":"2015-10-16T15:47:41.950+01:00","@version":1,"message":"Completed 'message' event: BUTTON_REQUEST","logger_name":"org.multibit.hd.hardware.core.events.MessageEvents","thread_name":"safe-fixed-message-events-0","level":"DEBUG","level_value":10000}
{"@timestamp":"2015-10-16T15:47:41.971+01:00","@version":1,"message":"Showing wizard panel: CREDENTIALS_PRESS_CONFIRM_FOR_UNLOCK","logger_name":"org.multibit.hd.ui.views.wizards.AbstractWizard","thread_name":"AWT-EventQueue-0","level":"DEBUG","level_value":10000}
{"@timestamp":"2015-10-16T15:47:43.994+01:00","@version":1,"message":"Device not attached","logger_name":"org.multibit.hd.hardware.trezor.wallets.v1.TrezorV1HidHardwareWallet","thread_name":"safe-scheduled-monitor-hw-client-0","level":"INFO","level_value":20000}
{"@timestamp":"2015-10-16T15:47:43.994+01:00","@version":1,"message":"Failed to locate. Device must be detached.","logger_name":"org.multibit.hd.hardware.trezor.wallets.v1.TrezorV1HidHardwareWallet","thread_name":"safe-scheduled-monitor-hw-client-0","level":"DEBUG","level_value":10000}
{"@timestamp":"2015-10-16T15:47:43.996+01:00","@version":1,"message":"Firing 'message' event type: DEVICE_DETACHED for TREZOR","logger_name":"org.multibit.hd.hardware.core.events.MessageEvents","thread_name":"safe-fixed-message-events-0","level":"DEBUG","level_value":10000}
{"@timestamp":"2015-10-16T15:47:43.996+01:00","@version":1,"message":"Discarded message event: 'DEVICE_DETACHED' (different device)","logger_name":"org.multibit.hd.hardware.core.fsm.HardwareWalletContext","thread_name":"safe-fixed-message-events-0","level":"DEBUG","level_value":10000}
{"@timestamp":"2015-10-16T15:47:43.997+01:00","@version":1,"message":"Received message event: 'DEVICE_DETACHED'","logger_name":"org.multibit.hd.hardware.core.fsm.HardwareWalletContext","thread_name":"safe-fixed-message-events-0","level":"DEBUG","level_value":10000}
{"@timestamp":"2015-10-16T15:47:43.998+01:00","@version":1,"message":"Performing client soft detach...","logger_name":"org.multibit.hd.hardware.trezor.clients.TrezorHardwareWalletClient","thread_name":"safe-fixed-message-events-0","level":"DEBUG","level_value":10000}
{"@timestamp":"2015-10-16T15:47:43.998+01:00","@version":1,"message":"Reset to 'detached'","logger_name":"org.multibit.hd.hardware.core.fsm.HardwareWalletContext","thread_name":"safe-fixed-message-events-0","level":"DEBUG","level_value":10000}
{"@timestamp":"2015-10-16T15:47:43.998+01:00","@version":1,"message":"Transitioning to 'detached' state","logger_name":"org.multibit.hd.hardware.core.fsm.HardwareWalletStates","thread_name":"safe-fixed-message-events-0","level":"DEBUG","level_value":10000}
{"@timestamp":"2015-10-16T15:47:44.000+01:00","@version":1,"message":"Firing 'hardware wallet' event: SHOW_DEVICE_DETACHED for TREZOR","logger_name":"org.multibit.hd.hardware.core.events.HardwareWalletEvents","thread_name":"safe-fixed-hardware-wallet-events-0","level":"DEBUG","level_value":10000}
{"@timestamp":"2015-10-16T15:47:44.001+01:00","@version":1,"message":"Received hardware event: 'SHOW_DEVICE_DETACHED'","logger_name":"org.multibit.hd.ui.controllers.MainController","thread_name":"safe-fixed-hardware-wallet-events-0","level":"DEBUG","level_value":10000}
{"@timestamp":"2015-10-16T15:47:44.001+01:00","@version":1,"message":"Selected deferred credentials type: PASSWORD","logger_name":"org.multibit.hd.ui.controllers.MainController","thread_name":"safe-fixed-hardware-wallet-events-0","level":"DEBUG","level_value":10000}
{"@timestamp":"2015-10-16T15:47:44.001+01:00","@version":1,"message":"org.multibit.hd.ui.views.wizards.credentials.CredentialsWizard@db1fb70 Received hardware event: 'SHOW_DEVICE_DETACHED'.","logger_name":"org.multibit.hd.ui.views.wizards.AbstractHardwareWalletWizard","thread_name":"safe-fixed-hardware-wallet-events-0","level":"DEBUG","level_value":10000}
{"@timestamp":"2015-10-16T15:47:44.003+01:00","@version":1,"message":"Completed 'message' event: DEVICE_DETACHED","logger_name":"org.multibit.hd.hardware.core.events.MessageEvents","thread_name":"safe-fixed-message-events-0","level":"DEBUG","level_value":10000}
{"@timestamp":"2015-10-16T15:47:44.004+01:00","@version":1,"message":"Device is now detached - showing password screen","logger_name":"org.multibit.hd.ui.views.wizards.credentials.CredentialsWizardModel","thread_name":"AWT-EventQueue-0","level":"DEBUG","level_value":10000}
{"@timestamp":"2015-10-16T15:47:44.005+01:00","@version":1,"message":"Searching for first ready hardware wallet...","logger_name":"org.multibit.hd.core.services.CoreServices","thread_name":"AWT-EventQueue-0","level":"DEBUG","level_value":10000}
{"@timestamp":"2015-10-16T15:47:44.004+01:00","@version":1,"message":"Completed 'hardware wallet' event: SHOW_DEVICE_DETACHED","logger_name":"org.multibit.hd.hardware.core.events.HardwareWalletEvents","thread_name":"safe-fixed-hardware-wallet-events-0","level":"DEBUG","level_value":10000}
{"@timestamp":"2015-10-16T15:47:44.791+01:00","@version":1,"message":"Showing wizard panel: CREDENTIALS_ENTER_PASSWORD","logger_name":"org.multibit.hd.ui.views.wizards.AbstractWizard","thread_name":"AWT-EventQueue-0","level":"DEBUG","level_value":10000}
{"@timestamp":"2015-10-16T15:47:45.761+01:00","@version":1,"message":"Packet complete","logger_name":"org.multibit.hd.hardware.keepkey.wallets.v1.KeepKeyV1HidHardwareWallet","thread_name":"safe-fixed-monitor-hid-0","level":"DEBUG","level_value":10000}
{"@timestamp":"2015-10-16T15:47:45.761+01:00","@version":1,"message":"Parsing 'MessageType_CipheredKeyValue' (18 bytes):","logger_name":"org.multibit.hd.hardware.keepkey.utils.KeepKeyMessageUtils","thread_name":"safe-fixed-monitor-hid-0","level":"INFO","level_value":20000}
{"@timestamp":"2015-10-16T15:47:45.769+01:00","@version":1,"message":"Firing 'message' event: CIPHERED_KEY_VALUE for KEEP_KEY","logger_name":"org.multibit.hd.hardware.core.events.MessageEvents","thread_name":"safe-fixed-message-events-0","level":"DEBUG","level_value":10000}
{"@timestamp":"2015-10-16T15:47:45.769+01:00","@version":1,"message":"Received message event: 'CIPHERED_KEY_VALUE'","logger_name":"org.multibit.hd.hardware.core.fsm.HardwareWalletContext","thread_name":"safe-fixed-message-events-0","level":"DEBUG","level_value":10000}
{"@timestamp":"2015-10-16T15:47:45.769+01:00","@version":1,"message":"Discarded message event: 'CIPHERED_KEY_VALUE' (different device)","logger_name":"org.multibit.hd.hardware.core.fsm.HardwareWalletContext","thread_name":"safe-fixed-message-events-0","level":"DEBUG","level_value":10000}
{"@timestamp":"2015-10-16T15:47:45.770+01:00","@version":1,"message":"Completed 'message' event: CIPHERED_KEY_VALUE","logger_name":"org.multibit.hd.hardware.core.events.MessageEvents","thread_name":"safe-fixed-message-events-0","level":"DEBUG","level_value":10000}
{"@timestamp":"2015-10-16T15:47:45.770+01:00","@version":1,"message":"Firing 'hardware wallet' event: SHOW_OPERATION_SUCCEEDED for KEEP_KEY","logger_name":"org.multibit.hd.hardware.core.events.HardwareWalletEvents","thread_name":"safe-fixed-hardware-wallet-events-0","level":"DEBUG","level_value":10000}
{"@timestamp":"2015-10-16T15:47:45.771+01:00","@version":1,"message":"Received hardware event: 'SHOW_OPERATION_SUCCEEDED'","logger_name":"org.multibit.hd.ui.controllers.MainController","thread_name":"safe-fixed-hardware-wallet-events-0","level":"DEBUG","level_value":10000}
{"@timestamp":"2015-10-16T15:47:45.771+01:00","@version":1,"message":"org.multibit.hd.ui.views.wizards.credentials.CredentialsWizard@db1fb70 Received hardware event: 'SHOW_OPERATION_SUCCEEDED'.","logger_name":"org.multibit.hd.ui.views.wizards.AbstractHardwareWalletWizard","thread_name":"safe-fixed-hardware-wallet-events-0","level":"DEBUG","level_value":10000}
{"@timestamp":"2015-10-16T15:47:45.773+01:00","@version":1,"message":"Completed 'hardware wallet' event: SHOW_OPERATION_SUCCEEDED","logger_name":"org.multibit.hd.hardware.core.events.HardwareWalletEvents","thread_name":"safe-fixed-hardware-wallet-events-0","level":"DEBUG","level_value":10000}
{"@timestamp":"2015-10-16T15:47:45.774+01:00","@version":1,"message":"Message:'Operation succeeded'\norg.multibit.hd.hardware.core.messages.CipheredKeyValue@7003e8b7[payload=Optional.of([B@5e1d817b)]","logger_name":"org.multibit.hd.ui.views.wizards.credentials.CredentialsWizardModel","thread_name":"AWT-EventQueue-0","level":"INFO","level_value":20000}
{"@timestamp":"2015-10-16T15:47:45.863+01:00","@version":1,"message":"Showing wizard panel: CREDENTIALS_ENTER_PASSWORD","logger_name":"org.multibit.hd.ui.views.wizards.AbstractWizard","thread_name":"AWT-EventQueue-0","level":"DEBUG","level_value":10000}
{"@timestamp":"2015-10-16T15:47:56.214+01:00","@version":1,"message":"Showing wizard panel: CREDENTIALS_LOAD_WALLET_REPORT","logger_name":"org.multibit.hd.ui.views.wizards.AbstractWizard","thread_name":"AWT-EventQueue-0","level":"DEBUG","level_value":10000}

It looks like there is a 'Trezor is detached' event that is disconnecting the KeepKey (???) and it drops to show the password entry screen. The test machine is quite slow so it could be something racey.

I checked the USB cable was securely seated so I don't think it is that.

jim618 commented 8 years ago

There are some installers that you might want to use on releases/multibit-hd-0.0.0 Built today

gary-rowe commented 8 years ago

It may be worth re-testing this in light of some changes I've made to #736.

jim618 commented 8 years ago

Rebuilt an installer for Windows and retested this. It all works fine with various combinations of plugging in and out, switching etc between Trezor, KeepKey and soft wallet.

Closing

jim618 commented 8 years ago

Also regression tested on Mac successfully