Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

Cannot connect my satellite anymore #262

Closed
devbar opened this issue Feb 16, 2025 · 9 comments
Closed

Cannot connect my satellite anymore #262

devbar opened this issue Feb 16, 2025 · 9 comments
Assignees
@goldyfruit @JarbasAl
Labels
bug Something isn't working
Milestone
Commander Keen

Comments

@devbar
Copy link

devbar commented Feb 16, 2025 •
edited
Loading

Hi guys,

after updating my OVOS installation I am not able to connect my satellite anymore.

On Hivemind master:

ovos-log --log hivemind

> -Node-1', node_type=<HiveMindNodeType.NODE: 'node'>, handshake=<poorman_handshake.asymmetric.HandShake object at 0x74c0619fb9e0>, pswd_handshake=<poorman_handshake.symmetric.PasswordHandShake object at 0x74c06194c9b0>, crypto_key='b017123e7f6e5f96', pub_key=None, msg_blacklist=[], skill_blacklist=[], intent_blacklist=[], allowed_types=['recognizer_loop:utterance', 'recognizer_loop:record_begin', 'recognizer_loop:record_end', 'recognizer_loop:audio_output_start', 'recognizer_loop:audio_output_end', 'recognizer_loop:b64_transcribe', 'speak:b64_audio', 'ovos.common_play.SEI.get.response'], binarize=False, site_id='unknown', can_escalate=True, can_propagate=True, is_admin=False, last_seen=-1, hm_protocol=HiveMindListenerProtocol(agent_protocol=OVOSProtocol(config={'host': '127.0.0.1', 'port': 8181}, hm_protocol=..., callbacks=ClientCallbacks(on_connect=<function on_connect at 0x74c0684120c0>, on_disconnect=<function on_disconnect at 0x74c0688f5ee0>, on_invalid_key=<function on_invalid_key at 0x74c068483420>, on_invalid_protocol=<function on_invalid_protocol at 0x74c0684834c0>), bus=<ovos_bus_client.client.client.MessageBusClient object at 0x74c068240110>), binary_data_protocol=BinaryDataHandlerProtocol(config={}, hm_protocol=..., callbacks=ClientCallbacks(on_connect=<function on_connect at 0x74c0684120c0>, on_disconnect=<function on_disconnect at 0x74c0688f5ee0>, on_invalid_key=<function on_invalid_key at 0x74c068483420>, on_invalid_protocol=<function on_invalid_protocol at 0x74c0684834c0>), agent_protocol=OVOSProtocol(config={'host': '127.0.0.1', 'port': 8181}, hm_protocol=..., callbacks=ClientCallbacks(on_connect=<function on_connect at 0x74c0684120c0>, on_disconnect=<function on_disconnect at 0x74c0688f5ee0>, on_invalid_key=<function on_invalid_key at 0x74c068483420>, on_invalid_protocol=<function on_invalid_protocol at 0x74c0684834c0>), bus=<ovos_bus_client.client.client.MessageBusClient object at 0x74c068240110>)), peer='master:0.0.0.0', require_crypto=True, handshake_enabled=True, identity=<hivemind_bus_client.identity.NodeIdentity object at 0x74c068391a00>, db=<hivemind_core.database.ClientDatabase object at 0x74c06849f620>, callbacks=ClientCallbacks(on_connect=<function on_connect at 0x74c0684120c0>, on_disconnect=<function on_disconnect at 0x74c0688f5ee0>, on_invalid_key=<function on_invalid_key at 0x74c068483420>, on_invalid_protocol=<function on_invalid_protocol at 0x74c0684834c0>)), cipher=<SupportedCiphers.AES_GCM: 'AES-GCM'>, encoding=<SupportedEncodings.JSON_HEX: 'JSON-HEX'>)
> 2025-02-16 10:10:11.799 - HiveMind - hivemind_core.protocol:handle_new_client:234 - DEBUG - new client: VoiceSatelliteV0.3.0::2::HiveMind-Node-1::default
> 2025-02-16 10:10:11.808 - HiveMind - hivemind_core.protocol:handle_new_client:261 - DEBUG - saying HELLO to: VoiceSatelliteV0.3.0::2::HiveMind-Node-1::default
> 2025-02-16 10:10:11.816 - HiveMind - hivemind_core.protocol:send:120 - DEBUG - sending to VoiceSatelliteV0.3.0::2::HiveMind-Node-1::default: HiveMessageType.HELLO
> 2025-02-16 10:10:11.821 - HiveMind - hivemind_core.protocol:send:143 - DEBUG - sent unencrypted!
> 2025-02-16 10:10:11.827 - HiveMind - hivemind_core.protocol:handle_new_client:285 - DEBUG - starting VoiceSatelliteV0.3.0::2::HiveMind-Node-1::default HANDSHAKE: {'handshake': False, 'min_protocol_version': <ProtocolVersion.ZERO: 0>, 'max_protocol_version': <ProtocolVersion.ONE: 1>, 'binarize': False, 'preshared_key': True, 'password': True, 'crypto_required': True, 'encodings': ['JSON-B64', 'JSON-URLSAFE-B64', 'JSON-B91', 'JSON-Z85B', 'JSON-Z85P', 'JSON-B32', 'JSON-HEX'], 'ciphers': ['AES-GCM', 'CHACHA20-POLY1305']}
> 2025-02-16 10:10:11.832 - HiveMind - hivemind_core.protocol:send:120 - DEBUG - sending to VoiceSatelliteV0.3.0::2::HiveMind-Node-1::default: HiveMessageType.HANDSHAKE
> 2025-02-16 10:10:11.837 - HiveMind - hivemind_core.protocol:send:143 - DEBUG - sent unencrypted!
> 2025-02-16 10:10:13.438 - HiveMind - hivemind_websocket_protocol:on_close:233 - INFO - disconnecting client: VoiceSatelliteV0.3.0::2::HiveMind-Node-1::default
> 2025-02-16 10:10:13.443 - HiveMind - hivemind_plugin_manager.protocols:on_disconnect:14 - DEBUG - callback: client disconnected: HiveMindClientConnection(key='ac12ea5c04370cadf294204379b0fed7', send_msg=<function HiveMindTornadoWebSocket.open.<locals>.do_send at 0x74c060304d60>, disconnect=<function HiveMindTornadoWebSocket.open.<locals>.do_disconnect at 0x74c060307b00>, sess=<ovos_bus_client.session.Session object at 0x74c0619f9b80>, name='VoiceSatelliteV0.3.0::2::HiveMind-Node-1', node_type=<HiveMindNodeType.NODE: 'node'>, handshake=<poorman_handshake.asymmetric.HandShake object at 0x74c0619fb9e0>, pswd_handshake=<poorman_handshake.symmetric.PasswordHandShake object at 0x74c06194c9b0>, crypto_key='b017123e7f6e5f96', pub_key=None, msg_blacklist=[], skill_blacklist=[], intent_blacklist=[], allowed_types=['recognizer_loop:utterance', 'recognizer_loop:record_begin', 'recognizer_loop:record_end', 'recognizer_loop:audio_output_start', 'recognizer_loop:audio_output_end', 'recognizer_loop:b64_transcribe', 'speak:b64_audio', 'ovos.common_play.SEI.get.response'], binarize=False, site_id='unknown', can_escalate=True, can_propagate=True, is_admin=False, last_seen=-1, hm_protocol=HiveMindListenerProtocol(agent_protocol=OVOSProtocol(config={'host': '127.0.0.1', 'port': 8181}, hm_protocol=..., callbacks=ClientCallbacks(on_connect=<function on_connect at 0x74c0684120c0>, on_disconnect=<function on_disconnect at 0x74c0688f5ee0>, on_invalid_key=<function on_invalid_key at 0x74c068483420>, on_invalid_protocol=<function on_invalid_protocol at 0x74c0684834c0>), bus=<ovos_bus_client.client.client.MessageBusClient object at 0x74c068240110>), binary_data_protocol=BinaryDataHandlerProtocol(config={}, hm_protocol=..., callbacks=ClientCallbacks(on_connect=<function on_connect at 0x74c0684120c0>, on_disconnect=<function on_disconnect at 0x74c0688f5ee0>, on_invalid_key=<function on_invalid_key at 0x74c068483420>, on_invalid_protocol=<function on_invalid_protocol at 0x74c0684834c0>), agent_protocol=OVOSProtocol(config={'host': '127.0.0.1', 'port': 8181}, hm_protocol=..., callbacks=ClientCallbacks(on_connect=<function on_connect at 0x74c0684120c0>, on_disconnect=<function on_disconnect at 0x74c0688f5ee0>, on_invalid_key=<function on_invalid_key at 0x74c068483420>, on_invalid_protocol=<function on_invalid_protocol at 0x74c0684834c0>), bus=<ovos_bus_client.client.client.MessageBusClient object at 0x74c068240110>)), peer='master:0.0.0.0', require_crypto=True, handshake_enabled=True, identity=<hivemind_bus_client.identity.NodeIdentity object at 0x74c068391a00>, db=<hivemind_core.database.ClientDatabase object at 0x74c06849f620>, callbacks=ClientCallbacks(on_connect=<function on_connect at 0x74c0684120c0>, on_disconnect=<function on_disconnect at 0x74c0688f5ee0>, on_invalid_key=<function on_invalid_key at 0x74c068483420>, on_invalid_protocol=<function on_invalid_protocol at 0x74c0684834c0>)), cipher=<SupportedCiphers.AES_GCM: 'AES-GCM'>, encoding=<SupportedEncodings.JSON_HEX: 'JSON-HEX'>)
> 2025-02-16 10:10:13.448 - HiveMind - hivemind_plugin_manager.protocols:on_disconnect:14 - DEBUG - callback: client disconnected: HiveMindClientConnection(key='ac12ea5c04370cadf294204379b0fed7', send_msg=<function HiveMindTornadoWebSocket.open.<locals>.do_send at 0x74c060304d60>, disconnect=<function HiveMindTornadoWebSocket.open.<locals>.do_disconnect at 0x74c060307b00>, sess=<ovos_bus_client.session.Session object at 0x74c0619f9b80>, name='VoiceSatelliteV0.3.0::2::HiveMind-Node-1', node_type=<HiveMindNodeType.NODE: 'node'>, handshake=<poorman_handshake.asymmetric.HandShake object at 0x74c0619fb9e0>, pswd_handshake=<poorman_handshake.symmetric.PasswordHandShake object at 0x74c06194c9b0>, crypto_key='b017123e7f6e5f96', pub_key=None, msg_blacklist=[], skill_blacklist=[], intent_blacklist=[], allowed_types=['recognizer_loop:utterance', 'recognizer_loop:record_begin', 'recognizer_loop:record_end', 'recognizer_loop:audio_output_start', 'recognizer_loop:audio_output_end', 'recognizer_loop:b64_transcribe', 'speak:b64_audio', 'ovos.common_play.SEI.get.response'], binarize=False, site_id='unknown', can_escalate=True, can_propagate=True, is_admin=False, last_seen=-1, hm_protocol=HiveMindListenerProtocol(agent_protocol=OVOSProtocol(config={'host': '127.0.0.1', 'port': 8181}, hm_protocol=..., callbacks=ClientCallbacks(on_connect=<function on_connect at 0x74c0684120c0>, on_disconnect=<function on_disconnect at 0x74c0688f5ee0>, on_invalid_key=<function on_invalid_key at 0x74c068483420>, on_invalid_protocol=<function on_invalid_protocol at 0x74c0684834c0>), bus=<ovos_bus_client.client.client.MessageBusClient object at 0x74c068240110>), binary_data_protocol=BinaryDataHandlerProtocol(config={}, hm_protocol=..., callbacks=ClientCallbacks(on_connect=<function on_connect at 0x74c0684120c0>, on_disconnect=<function on_disconnect at 0x74c0688f5ee0>, on_invalid_key=<function on_invalid_key at 0x74c068483420>, on_invalid_protocol=<function on_invalid_protocol at 0x74c0684834c0>), agent_protocol=OVOSProtocol(config={'host': '127.0.0.1', 'port': 8181}, hm_protocol=..., callbacks=ClientCallbacks(on_connect=<function on_connect at 0x74c0684120c0>, on_disconnect=<function on_disconnect at 0x74c0688f5ee0>, on_invalid_key=<function on_invalid_key at 0x74c068483420>, on_invalid_protocol=<function on_invalid_protocol at 0x74c0684834c0>), bus=<ovos_bus_client.client.client.MessageBusClient object at 0x74c068240110>)), peer='master:0.0.0.0', require_crypto=True, handshake_enabled=True, identity=<hivemind_bus_client.identity.NodeIdentity object at 0x74c068391a00>, db=<hivemind_core.database.ClientDatabase object at 0x74c06849f620>, callbacks=ClientCallbacks(on_connect=<function on_connect at 0x74c0684120c0>, on_disconnect=<function on_disconnect at 0x74c0688f5ee0>, on_invalid_key=<function on_invalid_key at 0x74c068483420>, on_invalid_protocol=<function on_invalid_protocol at 0x74c0684834c0>)), cipher=<SupportedCiphers.AES_GCM: 'AES-GCM'>, encoding=<SupportedEncodings.JSON_HEX: 'JSON-HEX'>)
> 2025-02-16 10:10:13.452 - HiveMind - hivemind_plugin_manager.protocols:on_disconnect:14 - DEBUG - callback: client disconnected: HiveMindClientConnection(key='ac12ea5c04370cadf294204379b0fed7', send_msg=<function HiveMindTornadoWebSocke
> t.open.<locals>.do_send at 0x74c060304d60>, disconnect=<function HiveMindTornadoWebSocket.open.<locals>.do_disconnect at 0x74c060307b00>, sess=<ovos_bus_client.session.Session object at 0x74c0619f9b80>, name='VoiceSatelliteV0.3.0::2::HiveMind-Node-1', node_type=<HiveMindNodeType.NODE: 'node'>, handshake=<poorman_handshake.asymmetric.HandShake object at 0x74c0619fb9e0>, pswd_handshake=<poorman_handshake.symmetric.PasswordHandShake object at 0x74c06194c9b0>, crypto_key='b017123e7f6e5f96', pub_key=None, msg_blacklist=[], skill_blacklist=[], intent_blacklist=[], allowed_types=['recognizer_loop:utterance', 'recognizer_loop:record_begin', 'recognizer_loop:record_end', 'recognizer_loop:audio_output_start', 'recognizer_loop:audio_output_end', 'recognizer_loop:b64_transcribe', 'speak:b64_audio', 'ovos.common_play.SEI.get.response'], binarize=False, site_id='unknown', can_escalate=True, can_propagate=True, is_admin=False, last_seen=-1, hm_protocol=HiveMindListenerProtocol(agent_protocol=OVOSProtocol(config={'host': '127.0.0.1', 'port': 8181}, hm_protocol=..., callbacks=ClientCallbacks(on_connect=<function on_connect at 0x74c0684120c0>, on_disconnect=<function on_disconnect at 0x74c0688f5ee0>, on_invalid_key=<function on_invalid_key at 0x74c068483420>, on_invalid_protocol=<function on_invalid_protocol at 0x74c0684834c0>), bus=<ovos_bus_client.client.client.MessageBusClient object at 0x74c068240110>), binary_data_protocol=BinaryDataHandlerProtocol(config={}, hm_protocol=..., callbacks=ClientCallbacks(on_connect=<function on_connect at 0x74c0684120c0>, on_disconnect=<function on_disconnect at 0x74c0688f5ee0>, on_invalid_key=<function on_invalid_key at 0x74c068483420>, on_invalid_protocol=<function on_invalid_protocol at 0x74c0684834c0>), agent_protocol=OVOSProtocol(config={'host': '127.0.0.1', 'port': 8181}, hm_protocol=..., callbacks=ClientCallbacks(on_connect=<function on_connect at 0x74c0684120c0>, on_disconnect=<function on_disconnect at 0x74c0688f5ee0>, on_invalid_key=<function on_invalid_key at 0x74c068483420>, on_invalid_protocol=<function on_invalid_protocol at 0x74c0684834c0>), bus=<ovos_bus_client.client.client.MessageBusClient object at 0x74c068240110>)), peer='master:0.0.0.0', require_crypto=True, handshake_enabled=True, identity=<hivemind_bus_client.identity.NodeIdentity object at 0x74c068391a00>, db=<hivemind_core.database.ClientDatabase object at 0x74c06849f620>, callbacks=ClientCallbacks(on_connect=<function on_connect at 0x74c0684120c0>, on_disconnect=<function on_disconnect at 0x74c0688f5ee0>, on_invalid_key=<function on_invalid_key at 0x74c068483420>, on_invalid_protocol=<function on_invalid_protocol at 0x74c0684834c0>)), cipher=<SupportedCiphers.AES_GCM: 'AES-GCM'>, encoding=<SupportedEncodings.JSON_HEX: 'JSON-HEX'>)
> (END)

On Satellite:

ovos-log --log hivemind-voice-sat

> 2025-02-16 10:01:51.636 - HiveMind-voice-sat - hivemind_bus_client.protocol:handle_hello:133 - INFO - HELLO: {'pubkey': '-----BEGIN PUBLIC KEY-----\nMIIBIjANBgkqhkiG9w0BAQEFAAOCAQ8AMIIBCgKCAQEAoq1oSO+NFqaAkQ3UKGa7\nNRQquncneXZL5fWIO0wSwxfIdIXQYVS7Zy7ndMGyuLcLjnFzlLmRFd2VfXSPoDqt\njtgEcDBOTMWASM0o/nmnU5EGk/Ec8OpfRmzVyU6fDEOF6OL8N3Xi5ZyfHuOZ4VQz\nYL2PtPg7g9SeGaPEQ3zBVMEyN1Sex+zahbMswuEEphplTkkkCxMP5brQdDhFwbEe\nAgiRWOUTnOOqt0vYxtsc5q175/O9zQ29q694LnDdqu0WCFggdkClkQSiecwuMDxZ\nqTqdllrPYGcg2lb6kfPWUqeOeXrTtsUwg6sU06McxtNtH9OYCYT4aeHJHpB6QO5i\n4wIDAQAB\n-----END PUBLIC KEY-----', 'peer': 'VoiceSatelliteV0.3.0::2::HiveMind-Node-1::default', 'node_id': 'master:0.0.0.0'}
> 2025-02-16 10:01:51.885 - HiveMind-voice-sat - hivemind_bus_client.protocol:handle_handshake:182 - INFO - HANDSHAKE: {'handshake': False, 'min_protocol_version': 0, 'max_protocol_version': 1, 'binarize': False, 'preshared_key': True, 'password': True, 'crypto_required': True, 'encodings': ['JSON-B64', 'JSON-URLSAFE-B64', 'JSON-B91', 'JSON-Z85B', 'JSON-Z85P', 'JSON-B32', 'JSON-HEX'], 'ciphers': ['AES-GCM', 'CHACHA20-POLY1305']}
> 2025-02-16 10:01:52.642 - HiveMind-voice-sat - hivemind_bus_client.protocol:start_handshake:144 - INFO - hivemind does not support binarization protocol
> 2025-02-16 10:01:53.902 - HiveMind-voice-sat - hivemind_bus_client.protocol:handle_handshake:182 - INFO - HANDSHAKE: {'envelope': '903e392b1dee0ba0d8c4d5837c8a64d3132f748541def808', 'encoding': 'JSON-B91', 'cipher': 'CHACHA20-POLY1305'}
> 2025-02-16 10:01:54.152 - HiveMind-voice-sat - hivemind_bus_client.protocol:receive_handshake:158 - INFO - Received password envelope
> 2025-02-16 10:01:56.345 - HiveMind-voice-sat - ovos_bus_client.client.client:on_error:110 - WARNING - Could not send message because connection has closed
> 2025-02-16 10:01:56.595 - HiveMind-voice-sat - ovos_bus_client.client.client:on_error:128 - WARNING - Message Bus Client will reconnect in 5.0 seconds.
> 2025-02-16 10:02:02.147 - HiveMind-voice-sat - hivemind_bus_client.protocol:handle_hello:133 - INFO - HELLO: {'pubkey': '-----BEGIN PUBLIC KEY-----\nMIIBIjANBgkqhkiG9w0BAQEFAAOCAQ8AMIIBCgKCAQEAoq1oSO+NFqaAkQ3UKGa7\nNRQquncneXZL5fWIO0wSwxfIdIXQYVS7Zy7ndMGyuLcLjnFzlLmRFd2VfXSPoDqt\njtgEcDBOTMWASM0o/nmnU5EGk/Ec8OpfRmzVyU6fDEOF6OL8N3Xi5ZyfHuOZ4VQz\nYL2PtPg7g9SeGaPEQ3zBVMEyN1Sex+zahbMswuEEphplTkkkCxMP5brQdDhFwbEe\nAgiRWOUTnOOqt0vYxtsc5q175/O9zQ29q694LnDdqu0WCFggdkClkQSiecwuMDxZ\nqTqdllrPYGcg2lb6kfPWUqeOeXrTtsUwg6sU06McxtNtH9OYCYT4aeHJHpB6QO5i\n4wIDAQAB\n-----END PUBLIC KEY-----', 'peer': 'VoiceSatelliteV0.3.0::2::HiveMind-Node-1::default', 'node_id': 'master:0.0.0.0'}
> 2025-02-16 10:02:02.398 - HiveMind-voice-sat - hivemind_bus_client.protocol:handle_handshake:182 - INFO - HANDSHAKE: {'handshake': False, 'min_protocol_version': 0, 'max_protocol_version': 1, 'binarize': False, 'preshared_key': True, 'password': True, 'crypto_required': True, 'encodings': ['JSON-B64', 'JSON-URLSAFE-B64', 'JSON-B91', 'JSON-Z85B', 'JSON-Z85P', 'JSON-B32', 'JSON-HEX'], 'ciphers': ['AES-GCM', 'CHACHA20-POLY1305']}
> 2025-02-16 10:02:03.161 - HiveMind-voice-sat - hivemind_bus_client.protocol:start_handshake:144 - INFO - hivemind does not support binarization protocol
> 2025-02-16 10:02:04.441 - HiveMind-voice-sat - hivemind_bus_client.protocol:handle_handshake:182 - INFO - HANDSHAKE: {'envelope': '6be6daeff605b81c33bf2a756c06cf729f5aafe343cde6c6', 'encoding': 'JSON-B91', 'cipher': 'CHACHA20-POLY1305'}
> 2025-02-16 10:02:04.689 - HiveMind-voice-sat - hivemind_bus_client.protocol:receive_handshake:158 - INFO - Received password envelope
> 2025-02-16 10:02:06.880 - HiveMind-voice-sat - ovos_bus_client.client.client:on_error:110 - WARNING - Could not send message because connection has closed
> 2025-02-16 10:02:07.127 - HiveMind-voice-sat - ovos_bus_client.client.client:on_error:128 - WARNING - Message Bus Client will reconnect in 5.0 seconds.
> 2025-02-16 10:02:12.729 - HiveMind-voice-sat - hivemind_bus_client.protocol:handle_hello:133 - INFO - HELLO: {'pubkey': '-----BEGIN PUBLIC KEY-----\nMIIBIjANBgkqhkiG9w0BAQEFAAOCAQ8AMIIBCgKCAQEAoq1oSO+NFqaAkQ3UKGa7\nNRQquncneXZL5fWIO0wSwxfIdIXQYVS7Zy7ndMGyuLcLjnFzlLmRFd2VfXSPoDqt\njtgEcDBOTMWASM0o/nmnU5EGk/Ec8OpfRmzVyU6fDEOF6OL8N3Xi5ZyfHuOZ4VQz\nYL2PtPg7g9SeGaPEQ3zBVMEyN1Sex+zahbMswuEEphplTkkkCxMP5brQdDhFwbEe\nAgiRWOUTnOOqt0vYxtsc5q175/O9zQ29q694LnDdqu0WCFggdkClkQSiecwuMDxZ\nqTqdllrPYGcg2lb6kfPWUqeOeXrTtsUwg6sU06McxtNtH9OYCYT4aeHJHpB6QO5i\n4wIDAQAB\n-----END PUBLIC KEY-----', 'peer': 'VoiceSatelliteV0.3.0::2::HiveMind-Node-1::default', 'node_id': 'master:0.0.0.0'}
> 2025-02-16 10:02:12.988 - HiveMind-voice-sat - hivemind_bus_client.protocol:handle_handshake:182 - INFO - HANDSHAKE: {'handshake': False, 'min_protocol_version': 0, 'max_protocol_version': 1, 'binarize': False, 'preshared_key': True, 'password': True, 'crypto_required': True, 'encodings': ['JSON-B64', 'JSON-URLSAFE-B64', 'JSON-B91', 'JSON-Z85B', 'JSON-Z85P', 'JSON-B32', 'JSON-HEX'], 'ciphers': ['AES-GCM', 'CHACHA20-POLY1305']}
> 2025-02-16 10:02:13.755 - HiveMind-voice-sat - hivemind_bus_client.protocol:start_handshake:144 - INFO - hivemind does not support binarization protocol
> 2025-02-16 10:02:15.054 - HiveMind-voice-sat - hivemind_bus_client.protocol:handle_handshake:182 - INFO - HANDSHAKE: {'envelope': '08e75fa7dcec724712f72b59dc5ed226b32d02dd565f9c0e', 'encoding': 'JSON-B91', 'cipher': 'CHACHA20-POLY1305'}
> 2025-02-16 10:02:15.328 - HiveMind-voice-sat - hivemind_bus_client.protocol:receive_handshake:158 - INFO - Received password envelope
> 2025-02-16 10:02:17.567 - HiveMind-voice-sat - ovos_bus_client.client.client:on_error:110 - WARNING - Could not send message because connection has closed
> 2025-02-16 10:02:17.812 - HiveMind-voice-sat - ovos_bus_client.client.client:on_error:128 - WARNING - Message Bus Client will reconnect in 5.0 seconds.
> 2025-02-16 10:02:23.792 - HiveMind-voice-sat - hivemind_bus_client.protocol:handle_hello:133 - INFO - HELLO: {'pubkey': '-----BEGIN PUBLIC KEY-----\nMIIBIjANBgkqhkiG9w0BAQEFAAOCAQ8AMIIBCgKCAQEAoq1oSO+NFqaAkQ3UKGa7\nNRQquncneXZL5fWIO0wSwxfIdIXQYVS7Zy7ndMGyuLcLjnFzlLmRFd2VfXSPoDqt\njtgEcDBOTMWASM0o/nmnU5EGk/Ec8OpfRmzVyU6fDEOF6OL8N3Xi5ZyfHuOZ4VQz\nYL2PtPg7g9SeGaPEQ3zBVMEyN1Sex+zahbMswuEEphplTkkkCxMP5brQdDhFwbEe\nAgiRWOUTnOOqt0vYxtsc5q175/O9zQ29q694LnDdqu0WCFggdkClkQSiecwuMDxZ\nqTqdllrPYGcg2lb6kfPWUqeOeXrTtsUwg6sU06McxtNtH9OYCYT4aeHJHpB6QO5i\n4wIDAQAB\n-----END PUBLIC KEY-----', 'peer': 'VoiceSatelliteV0.3.0::2::HiveMind-Node-1::default', 'node_id': 'master:0.0.0.0'}
> 2025-02-16 10:02:24.052 - HiveMind-voice-sat - hivemind_bus_client.protocol:handle_handshake:182 - INFO - HANDSHAKE: {'handshake': False, 'min_protocol_version': 0, 'max_protocol_version': 1, 'binarize': False, 'preshared_key': True, 'password': True, 'crypto_required': True, 'encodings': ['JSON-B64', 'JSON-URLSAFE-B64', 'JSON-B91', 'JSON-Z85B', 'JSON-Z85P', 'JSON-B32', 'JSON-HEX'], 'ciphers': ['AES-GCM', 'CHACHA20-POLY1305']}
> 2025-02-16 10:02:24.834 - HiveMind-voice-sat - hivemind_bus_client.protocol:start_handshake:144 - INFO - hivemind does not support binarization protocol
> 2025-02-16 10:02:26.110 - HiveMind-voice-sat - hivemind_bus_client.protocol:handle_handshake:182 - INFO - HANDSHAKE: {'envelope': '8c65c4b6bd2cbdb792a8e221d7faecab413e698b00b41077', 'encoding': 'JSON-B91', 'cipher': 'CHACHA20-POLY1305'}
> 2025-02-16 10:02:26.365 - HiveMind-voice-sat - hivemind_bus_client.protocol:receive_handshake:158 - INFO - Received password envelope
> 2025-02-16 10:02:28.605 - HiveMind-voice-sat - ovos_bus_client.client.client:on_error:110 - WARNING - Could not send message because connection has closed
> 2025-02-16 10:02:28.859 - HiveMind-voice-sat - ovos_bus_client.client.client:on_error:128 - WARNING - Message Bus Client will reconnect in 5.0 seconds.
> 2025-02-16 10:02:34.429 - HiveMind-voice-sat - hivemind_bus_client.protocol:handle_hello:133 - INFO - HELLO: {'pubkey': '-----BEGIN PUBLIC KEY-----\nMIIBIjANBgkqhkiG9w0BAQEFAAOCAQ8AMIIBCgKCAQEAoq1oSO+NFqaAkQ3UKGa7\nNRQquncneXZL5fWIO0wSwxfIdIXQYVS7Zy7ndMGyuLcLjnFzlLmRFd2VfXSPoDqt\njtgEcDBOTMWASM0o/nmnU5EGk/Ec8OpfRmzVyU6fDEOF6OL8N3Xi5ZyfHuOZ4VQz\nYL2PtPg7g9SeGaPEQ3zBVMEyN1Sex+zahbMswuEEphplTkkkCxMP5brQdDhFwbEe\nAgiRWOUTnOOqt0vYxtsc5q175/O9zQ29q694LnDdqu0WCFggdkClkQSiecwuMDxZ\nqTqdllrPYGcg2lb6kfPWUqeOeXrTtsUwg6sU06McxtNtH9OYCYT4aeHJHpB6QO5i\n4wIDAQAB\n-----END PUBLIC KEY-----', 'peer': 'VoiceSatelliteV0.3.0::2::HiveMind-Node-1::default', 'node_id': 'master:0.0.0.0'}
> 2025-02-16 10:02:34.687 - HiveMind-voice-sat - hivemind_bus_client.protocol:handle_handshake:182 - INFO - HANDSHAKE: {'handshake': False, 'min_protocol_version': 0, 'max_protocol_version': 1, 'binarize': False, 'preshared_key': True, 'password': True, 'crypto_required': True, 'encodings': ['JSON-B64', 'JSON-URLSAFE-B64', 'JSON-B91', 'JSON-Z85B', 'JSON-Z85P', 'JSON-B32', 'JSON-HEX'], 'ciphers': ['AES-GCM', 'CHACHA20-POLY1305']}
> 2025-02-16 10:02:35.470 - HiveMind-voice-sat - hivemind_bus_client.protocol:start_handshake:144 - INFO - hivemind does not support binarization protocol
> 2025-02-16 10:02:36.758 - HiveMind-voice-sat - hivemind_bus_client.protocol:handle_handshake:182 - INFO - HANDSHAKE: {'envelope': 'a7e6f299d0dd20bb351e65cacc85a6a9a2a0eee4d79c7fa9', 'encoding': 'JSON-B91', 'cipher': 'CHACHA20-POLY1305'}
> 2025-02-16 10:02:37.013 - HiveMind-voice-sat - hivemind_bus_client.protocol:receive_handshake:158 - INFO - Received password envelope
> 2025-02-16 10:02:39.265 - HiveMind-voice-sat - ovos_bus_client.client.client:on_error:110 - WARNING - Could not send message because connection has closed
> 2025-02-16 10:02:39.524 - HiveMind-voice-sat - ovos_bus_client.client.client:on_error:128 - WARNING - Message Bus Client will reconnect in 5.0 seconds.
> 2025-02-16 10:02:45.082 - HiveMind-voice-sat - hivemind_bus_client.protocol:handle_hello:133 - INFO - HELLO: {'pubkey': '-----BEGIN PUBLIC KEY-----\nMIIBIjANBgkqhkiG9w0BAQEFAAOCAQ8AMIIBCgKCAQEAoq1oSO+NFqaAkQ3UKGa7\nNRQquncneXZL5fWIO0wSwxfIdIXQYVS7Zy7ndMGyuLcLjnFzlLmRFd2VfXSPoDqt\njtgEcDBOTMWASM0o/nmnU5EGk/Ec8OpfRmzVyU6fDEOF6OL8N3Xi5ZyfHuOZ4VQz\nYL2PtPg7g9SeGaPEQ3zBVMEyN1Sex+zahbMswuEEphplTkkkCxMP5brQdDhFwbEe\nAgiRWOUTnOOqt0vYxtsc5q175/O9zQ29q694LnDdqu0WCFggdkClkQSiecwuMDxZ\nqTqdllrPYGcg2lb6kfPWUqeOeXrTtsUwg6sU06McxtNtH9OYCYT4aeHJHpB6QO5i\n4wIDAQAB\n-----END PUBLIC KEY-----', 'peer': 'VoiceSatelliteV0.3.0::2::HiveMind-Node-1::default', 'node_id': 'master:0.0.0.0'}
> 2025-02-16 10:02:45.342 - HiveMind-voice-sat - hivemind_bus_client.protocol:handle_handshake:182 - INFO - HANDSHAKE: {'handshake': False, 'min_protocol_version': 0, 'max_protocol_version': 1, 'binarize': False, 'preshared_key': True, 'password': True, 'crypto_required': True, 'encodings': ['JSON-B64', 'JSON-URLSAFE-B64', 'JSON-B91', 'JSON-Z85B', 'JSON-Z85P', 'JSON-B32', 'JSON-HEX'], 'ciphers': ['AES-GCM', 'CHACHA20-POLY1305']}
> 2025-02-16 10:02:46.130 - HiveMind-voice-sat - hivemind_bus_client.protocol:start_handshake:144 - INFO - hivemind does not support binarization protocol
> 2025-02-16 10:02:47.206 - HiveMind-voice-sat - hivemind_bus_client.protocol:handle_handshake:182 - INFO - HANDSHAKE: {'envelope': 'bf3527109db5cb2a0e891e2c0e5466a77b5f94c2604854e8', 'encoding': 'JSON-B91', 'cipher': 'CHACHA20-POLY1305'}
> 2025-02-16 10:02:47.465 - HiveMind-voice-sat - hivemind_bus_client.protocol:receive_handshake:158 - INFO - Received password envelope
> 2025-02-16 10:02:49.714 - HiveMind-voice-sat - ovos_bus_client.client.client:on_error:110 - WARNING - Could not send message because connection has closed

It does not feel like a handshake issue, because testing the pairing work as expected,

hivemind-client test-identity

> 2025-02-16 10:09:29.566 - OVOS - hivemind_bus_client.client:__init__:136 - INFO - Session ID: eff00760-49b1-4be3-b866-59ba580fadd9
> 2025-02-16 10:09:29.570 - OVOS - ovos_bus_client.conf:load_message_bus_config:28 - DEBUG - Loading message bus configs
> 2025-02-16 10:09:29.577 - OVOS - hivemind_bus_client.client:on_mycroft:403 - DEBUG - registering mycroft event: ovos.session.update_default
> 2025-02-16 10:09:29.588 - OVOS - hivemind_bus_client.client:connect:199 - DEBUG - Initializing HiveMindSlaveProtocol
> 2025-02-16 10:09:29.591 - OVOS - hivemind_bus_client.client:connect:210 - INFO - Connecting to Hivemind
> 2025-02-16 10:09:29.687 - OVOS - hivemind_bus_client.client:on_open:220 - DEBUG - Connected
> 2025-02-16 10:09:29.975 - OVOS - hivemind_bus_client.protocol:bind:104 - INFO - Initializing HiveMindSlaveInternalProtocol
> 2025-02-16 10:09:29.979 - OVOS - hivemind_bus_client.protocol:bind:107 - INFO - registering protocol handlers
> 2025-02-16 10:09:29.983 - OVOS - hivemind_bus_client.client:on:417 - DEBUG - registering handler: HiveMessageType.HELLO
> 2025-02-16 10:09:29.987 - OVOS - hivemind_bus_client.client:on:417 - DEBUG - registering handler: HiveMessageType.BROADCAST
> 2025-02-16 10:09:29.991 - OVOS - hivemind_bus_client.client:on:417 - DEBUG - registering handler: HiveMessageType.PROPAGATE
> 2025-02-16 10:09:30.007 - OVOS - hivemind_bus_client.client:on:417 - DEBUG - registering handler: HiveMessageType.INTERCOM
> 2025-02-16 10:09:30.011 - OVOS - hivemind_bus_client.client:on:417 - DEBUG - registering handler: HiveMessageType.ESCALATE
> 2025-02-16 10:09:30.016 - OVOS - hivemind_bus_client.client:on:417 - DEBUG - registering handler: HiveMessageType.SHARED_BUS
> 2025-02-16 10:09:30.020 - OVOS - hivemind_bus_client.client:on:417 - DEBUG - registering handler: HiveMessageType.BUS
> 2025-02-16 10:09:30.024 - OVOS - hivemind_bus_client.client:on:417 - DEBUG - registering handler: HiveMessageType.HANDSHAKE
> 2025-02-16 10:09:35.028 - OVOS - hivemind_bus_client.protocol:start_handshake:144 - INFO - hivemind does not support binarization protocol
> 2025-02-16 10:09:35.529 - OVOS - hivemind_bus_client.client:emit:369 - DEBUG - sending to HiveMind: HiveMessageType.HANDSHAKE
> 2025-02-16 10:09:35.675 - OVOS - hivemind_bus_client.protocol:handle_handshake:182 - INFO - HANDSHAKE: {'envelope': 'f328326a03ce85352f2cfd12c0172f31e4653379ef012dda', 'encoding': 'JSON-B91', 'cipher': 'CHACHA20-POLY1305'}
> 2025-02-16 10:09:35.682 - OVOS - hivemind_bus_client.protocol:receive_handshake:158 - INFO - Received password envelope
> 2025-02-16 10:09:36.161 - OVOS - hivemind_bus_client.client:emit:369 - DEBUG - sending to HiveMind: HiveMessageType.HELLO
> == Identity successfully connected to HiveMind!
> 2025-02-16 10:09:36.176 - OVOS - hivemind_bus_client.protocol:handle_handshake:189 - DEBUG - Encoding: JSON-B91
>

I also tried to start with a fresh re-installation, but with not luck.
@goldyfruit
Copy link
Member

Hi @devbar

Did you update your HiveMind Listener (server) as well, sometime its a requirement depending the changes in the code.

@goldyfruit goldyfruit added the bug Something isn't working label Feb 16, 2025
@goldyfruit goldyfruit added this to the Commander Keen milestone Feb 16, 2025
@devbar
Copy link
Author

devbar commented Feb 16, 2025

I made fresh reinstall on both: satellite and server

Do I have to check some other components too? Some caches still having old components?

@goldyfruit
Copy link
Member

I don't think is an ovos-installer's issue related but mainly an issue with HiveMind.

Maybe @JarbasAl has an idea.

@devbar
Copy link
Author

devbar commented Feb 17, 2025

I tried to make a vanilla installation with scenarion server in a docker environment and got a new hint what's going in here.

Satellite/raspi is sending no DRADIS contact when testing identity:

hivemind-client test-identity

2025-02-17 11:02:52.300 - OVOS - hivemind_bus_client.client:__init__:136 - INFO - Session ID: da124f40-e8e9-4b3f-be14-c7fef4042f9b
2025-02-17 11:02:52.304 - OVOS - ovos_bus_client.conf:load_message_bus_config:28 - DEBUG - Loading message bus configs
2025-02-17 11:02:52.312 - OVOS - hivemind_bus_client.client:on_mycroft:403 - DEBUG - registering mycroft event: ovos.session.update_default
2025-02-17 11:02:52.324 - OVOS - hivemind_bus_client.client:connect:199 - DEBUG - Initializing HiveMindSlaveProtocol
2025-02-17 11:02:52.328 - OVOS - hivemind_bus_client.client:connect:210 - INFO - Connecting to Hivemind
2025-02-17 11:02:52.417 - OVOS - hivemind_bus_client.client:on_open:220 - DEBUG - Connected
2025-02-17 11:02:52.701 - OVOS - hivemind_bus_client.protocol:bind:104 - INFO - Initializing HiveMindSlaveInternalProtocol
2025-02-17 11:02:52.705 - OVOS - hivemind_bus_client.protocol:bind:107 - INFO - registering protocol handlers
2025-02-17 11:02:52.709 - OVOS - hivemind_bus_client.client:on:417 - DEBUG - registering handler: HiveMessageType.HELLO
2025-02-17 11:02:52.713 - OVOS - hivemind_bus_client.client:on:417 - DEBUG - registering handler: HiveMessageType.BROADCAST
2025-02-17 11:02:52.718 - OVOS - hivemind_bus_client.client:on:417 - DEBUG - registering handler: HiveMessageType.PROPAGATE
2025-02-17 11:02:52.733 - OVOS - hivemind_bus_client.client:on:417 - DEBUG - registering handler: HiveMessageType.INTERCOM
2025-02-17 11:02:52.739 - OVOS - hivemind_bus_client.client:on:417 - DEBUG - registering handler: HiveMessageType.ESCALATE
2025-02-17 11:02:52.744 - OVOS - hivemind_bus_client.client:on:417 - DEBUG - registering handler: HiveMessageType.SHARED_BUS
2025-02-17 11:02:52.748 - OVOS - hivemind_bus_client.client:on:417 - DEBUG - registering handler: HiveMessageType.BUS
2025-02-17 11:02:52.753 - OVOS - hivemind_bus_client.client:on:417 - DEBUG - registering handler: HiveMessageType.HANDSHAKE
2025-02-17 11:02:57.761 - OVOS - hivemind_bus_client.protocol:start_handshake:144 - INFO - hivemind does not support binarization protocol
2025-02-17 11:02:58.224 - OVOS - hivemind_bus_client.client:emit:369 - DEBUG - sending to HiveMind: HiveMessageType.HANDSHAKE
2025-02-17 11:02:58.529 - OVOS - hivemind_bus_client.protocol:handle_handshake:182 - INFO - HANDSHAKE: {'envelope': 'a051d8d6eb6a20a14ac6d6a8e71436fc548709093c6d62ae', 'encoding': 'JSON-B91', 'cipher': 'CHACHA20-POLY1305'}
2025-02-17 11:02:58.535 - OVOS - hivemind_bus_client.protocol:receive_handshake:158 - INFO - Received password envelope
2025-02-17 11:02:59.010 - OVOS - hivemind_bus_client.client:emit:369 - DEBUG - sending to HiveMind: HiveMessageType.HELLO
== Identity successfully connected to HiveMind!
2025-02-17 11:02:59.024 - OVOS - hivemind_bus_client.protocol:handle_handshake:189 - DEBUG - Encoding: JSON-B91

But hivemind-listener found the cylon base91 ship:

2025-02-17 11:02:58.235 - HiveMind - hivemind_websocket_protocol:on_message:164 - INFO - Received HiveMessageBusClientV0.0.1::1::satellite_1::default message: {"msg_type": "shake", "payload": {"binarize": false, "encodings": ["JSON-B91", "JSON-Z85B", "JSON-Z85P", "JSON-B64", "JSON-URLSAFE-B64", "JSON-B32", "JSON-HEX"], "ciphers": ["CHACHA20-POLY1305", "AES-GCM"], "envelope": "XXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXX"}, "metadata": {}, "route": [], "node": null, "target_site_id": null, "target_pubkey": null, "source_peer": null}
2025-02-17 11:02:59,017 - ERROR - Uncaught exception GET /?authorization=XXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXX= (192.168.30.247)
HTTPServerRequest(protocol='http', host='192.168.30.254:5678', method='GET', uri='/?authorization=XXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXX=', version='HTTP/1.1', remote_ip='192.168.30.247')
Traceback (most recent call last):
  File "/home/hivemind/.venv/lib/python3.13/site-packages/tornado/websocket.py", line 631, in _run_callback
    result = callback(*args, **kwargs)
  File "/home/hivemind/.venv/lib/python3.13/site-packages/hivemind_websocket_protocol/__init__.py", line 157, in on_message
    message = self.client.decode(message)
  File "/home/hivemind/.venv/lib/python3.13/site-packages/hivemind_core/protocol.py", line 155, in decode
    payload = decrypt_from_json(key=self.crypto_key, ciphertext_json=payload,
                                encoding=self.encoding, cipher=self.cipher)
  File "/home/hivemind/.venv/lib/python3.13/site-packages/hivemind_bus_client/encryption.py", line 273, in decrypt_from_json
    ciphertext: bytes = decoder(ciphertext_json["ciphertext"])
                        ~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  File "/home/hivemind/.venv/lib/python3.13/site-packages/z85base91/__init__.py", line 175, in decode
    raise ValueError("Invalid Base91 string")
ValueError: Invalid Base91 string
2025-02-17 11:02:59.028 - HiveMind - hivemind_websocket_protocol:on_close:233 - INFO - disconnecting client: HiveMessageBusClientV0.0.1::1::satellite_1::default

I will investigate into satellite, maybe there is a way to switch to another encoding(?)

@JarbasAl
Copy link
Member

what is in your ~/.config/hivemind-core/server.json ?

allowed encodings (and order of preference) are defined there (server side)

json-b64 should be the default one used https://github.com/JarbasHiveMind/HiveMind-core/blob/dev/hivemind_core/config.py#L12

@devbar
Copy link
Author

devbar commented Feb 17, 2025

@JarbasAl I removed "JSON-B91" from server.json, worked for me!

I don't know why satellite is picking this.

@JarbasAl
Copy link
Member

the satellite only report available encodings, the server makes the final decision of what is used. this is done simply by picking the first enconding in the config that is also supported by the satellite (and throwing an error if no encoding in common)

guess i need to look into whats up with the B91 encoding, but that shouldnt be the default one in any case, did you modify your config or did that happen "by itself"?

@devbar
Copy link
Author

devbar commented Feb 17, 2025

It did "by itself". I tested with a vanilla installation (in and outside docker)

@goldyfruit
Copy link
Member

Gonna close for now, please re-open if needed.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees

@goldyfruit goldyfruit

@JarbasAl JarbasAl

Labels
bug Something isn't working
Projects
None yet
Milestone
Commander Keen
Development

No branches or pull requests
3 participants
@goldyfruit @devbar @JarbasAl