Documentation Preview for 2.5

since the version number was not incremented yet I am not quite sure whether it is actually working yet. I did not test it myself yet

I did. Running docker image 2.5-pre on master server and one satellite for testing. I am using rasa on another docker 2.4.18 (with http api) since rasa is currently not supported on 2.5 but all my training and nlu is in rasa (was hard way from snips to rasa though).
UDP Streaming for wake word on satellite looks good. Had to tweak inside of container a little for my configuration. Hermes-led-control works also.
Really nice!

1 Like

Very glad to see folks giving the code a try :slight_smile: My plan is to do an “official” pre-release next week after a few more bugs are worked out (big thanks to @KiboOst!).

@paddsen, I have the start of a Rasa NLU service for 2.5. Would you (or anyone else) but interested in completing it and testing it out? I have the basic infrastructure there and the generation of examples done, but it’s not contacting a Rasa NLU server yet.

Also, any tweaks or successes (like Hermes-led-control) are great to hear about!

1 Like

@synesthesiam the new commit for docker utf8 locale was something I also had to tweak.
In my case the Asr (from_dict) had problems when json includes „tokens“. I worked around by adding a pop for tokens.

I would be happy to test rasa code, but sadly I do not have the skills to add those implementation by myself. I would mess up your beautiful source :grin:

1 Like

OK, no worries. And thank you for referring to my source as “beautiful”. Other folks may use the terms “gnarly” or “ravings of a mad man.”

1 Like

Hi,
I’m just playing with Rhasspy 2.5 Voltron with German profile, installed on a Raspi 4 with docker.
I have a problem to connect to an external MQTT-broker ( 192.168.192.29:1891) :
after saving the profile and restart Rhasspy there’s an error-message that the MQTT-broker could not be connected .

Here is the log:

[ERROR:1551627] __main__: Failed to connect to MQTT broker
Traceback (most recent call last):
  File "/usr/lib/rhasspy-voltron/.venv/lib/python3.6/site-packages/quart/app.py", line 1471, in full_dispatch_request
    result = await self.dispatch_request(request_context)
  File "/usr/lib/rhasspy-voltron/.venv/lib/python3.6/site-packages/quart/app.py", line 1519, in dispatch_request
    return await handler(**request_.view_args)
  File "/usr/lib/rhasspy-voltron/rhasspy-server-hermes/rhasspyserver_hermes/__main__.py", line 1137, in api_restart
    await start_rhasspy()
  File "/usr/lib/rhasspy-voltron/rhasspy-server-hermes/rhasspyserver_hermes/__main__.py", line 424, in start_rhasspy
    await core.start()
  File "/usr/lib/rhasspy-voltron/rhasspy-server-hermes/rhasspyserver_hermes/__init__.py", line 230, in start
    raise RuntimeError("Failed to connect to MQTT broker")
RuntimeError: Failed to connect to MQTT broker
[CRITICAL:1551626] rhasspyserver_hermes: Failed to connect to MQTT broker (192.168.192.29:1891)
[ERROR:1550623] rhasspyserver_hermes: mqtt connect
Traceback (most recent call last):
  File "/usr/lib/rhasspy-voltron/rhasspy-server-hermes/rhasspyserver_hermes/__init__.py", line 217, in start
    self.client.connect(self.host, self.port)
  File "/usr/lib/rhasspy-voltron/.venv/lib/python3.6/site-packages/paho/mqtt/client.py", line 936, in connect
    bind_address, bind_port, clean_start, properties)
  File "/usr/lib/rhasspy-voltron/.venv/lib/python3.6/site-packages/paho/mqtt/client.py", line 1002, in connect_async
    if port <= 0:
TypeError: '<=' not supported between instances of 'str' and 'int'
[DEBUG:1550622] rhasspyserver_hermes: Connecting to 192.168.192.29:1891 (retries: 9)
[ERROR:1549619] rhasspyserver_hermes: mqtt connect
Traceback (most recent call last):
  File "/usr/lib/rhasspy-voltron/rhasspy-server-hermes/rhasspyserver_hermes/__init__.py", line 217, in start
    self.client.connect(self.host, self.port)
  File "/usr/lib/rhasspy-voltron/.venv/lib/python3.6/site-packages/paho/mqtt/client.py", line 936, in connect
    bind_address, bind_port, clean_start, properties)
  File "/usr/lib/rhasspy-voltron/.venv/lib/python3.6/site-packages/paho/mqtt/client.py", line 1002, in connect_async
    if port <= 0:
TypeError: '<=' not supported between instances of 'str' and 'int'
[DEBUG:1549618] rhasspyserver_hermes: Connecting to 192.168.192.29:1891 (retries: 8)
[ERROR:1548613] rhasspyserver_hermes: mqtt connect
Traceback (most recent call last):
  File "/usr/lib/rhasspy-voltron/rhasspy-server-hermes/rhasspyserver_hermes/__init__.py", line 217, in start
    self.client.connect(self.host, self.port)
  File "/usr/lib/rhasspy-voltron/.venv/lib/python3.6/site-packages/paho/mqtt/client.py", line 936, in connect
    bind_address, bind_port, clean_start, properties)
  File "/usr/lib/rhasspy-voltron/.venv/lib/python3.6/site-packages/paho/mqtt/client.py", line 1002, in connect_async
    if port <= 0:
TypeError: '<=' not supported between instances of 'str' and 'int'
[DEBUG:1548612] rhasspyserver_hermes: Connecting to 192.168.192.29:1891 (retries: 7)
[ERROR:1547608] rhasspyserver_hermes: mqtt connect
Traceback (most recent call last):
  File "/usr/lib/rhasspy-voltron/rhasspy-server-hermes/rhasspyserver_hermes/__init__.py", line 217, in start
    self.client.connect(self.host, self.port)
  File "/usr/lib/rhasspy-voltron/.venv/lib/python3.6/site-packages/paho/mqtt/client.py", line 936, in connect
    bind_address, bind_port, clean_start, properties)
  File "/usr/lib/rhasspy-voltron/.venv/lib/python3.6/site-packages/paho/mqtt/client.py", line 1002, in connect_async
    if port <= 0:
TypeError: '<=' not supported between instances of 'str' and 'int'
[DEBUG:1547607] rhasspyserver_hermes: Connecting to 192.168.192.29:1891 (retries: 6)
[ERROR:1546603] rhasspyserver_hermes: mqtt connect
Traceback (most recent call last):
  File "/usr/lib/rhasspy-voltron/rhasspy-server-hermes/rhasspyserver_hermes/__init__.py", line 217, in start
    self.client.connect(self.host, self.port)
  File "/usr/lib/rhasspy-voltron/.venv/lib/python3.6/site-packages/paho/mqtt/client.py", line 936, in connect
    bind_address, bind_port, clean_start, properties)
  File "/usr/lib/rhasspy-voltron/.venv/lib/python3.6/site-packages/paho/mqtt/client.py", line 1002, in connect_async
    if port <= 0:
TypeError: '<=' not supported between instances of 'str' and 'int'
[DEBUG:1546603] rhasspyserver_hermes: Connecting to 192.168.192.29:1891 (retries: 5)
[ERROR:1545599] rhasspyserver_hermes: mqtt connect
Traceback (most recent call last):
  File "/usr/lib/rhasspy-voltron/rhasspy-server-hermes/rhasspyserver_hermes/__init__.py", line 217, in start
    self.client.connect(self.host, self.port)
  File "/usr/lib/rhasspy-voltron/.venv/lib/python3.6/site-packages/paho/mqtt/client.py", line 936, in connect
    bind_address, bind_port, clean_start, properties)
  File "/usr/lib/rhasspy-voltron/.venv/lib/python3.6/site-packages/paho/mqtt/client.py", line 1002, in connect_async
    if port <= 0:
TypeError: '<=' not supported between instances of 'str' and 'int'
[DEBUG:1545598] rhasspyserver_hermes: Connecting to 192.168.192.29:1891 (retries: 4)
[ERROR:1544595] rhasspyserver_hermes: mqtt connect
Traceback (most recent call last):
  File "/usr/lib/rhasspy-voltron/rhasspy-server-hermes/rhasspyserver_hermes/__init__.py", line 217, in start
    self.client.connect(self.host, self.port)
  File "/usr/lib/rhasspy-voltron/.venv/lib/python3.6/site-packages/paho/mqtt/client.py", line 936, in connect
    bind_address, bind_port, clean_start, properties)
  File "/usr/lib/rhasspy-voltron/.venv/lib/python3.6/site-packages/paho/mqtt/client.py", line 1002, in connect_async
    if port <= 0:
TypeError: '<=' not supported between instances of 'str' and 'int'
[DEBUG:1544594] rhasspyserver_hermes: Connecting to 192.168.192.29:1891 (retries: 3)
[ERROR:1543592] rhasspyserver_hermes: mqtt connect
Traceback (most recent call last):
  File "/usr/lib/rhasspy-voltron/rhasspy-server-hermes/rhasspyserver_hermes/__init__.py", line 217, in start
    self.client.connect(self.host, self.port)
  File "/usr/lib/rhasspy-voltron/.venv/lib/python3.6/site-packages/paho/mqtt/client.py", line 936, in connect
    bind_address, bind_port, clean_start, properties)
  File "/usr/lib/rhasspy-voltron/.venv/lib/python3.6/site-packages/paho/mqtt/client.py", line 1002, in connect_async
    if port <= 0:
TypeError: '<=' not supported between instances of 'str' and 'int'
[DEBUG:1543592] rhasspyserver_hermes: Connecting to 192.168.192.29:1891 (retries: 2)
[ERROR:1542588] rhasspyserver_hermes: mqtt connect
Traceback (most recent call last):
  File "/usr/lib/rhasspy-voltron/rhasspy-server-hermes/rhasspyserver_hermes/__init__.py", line 217, in start
    self.client.connect(self.host, self.port)
  File "/usr/lib/rhasspy-voltron/.venv/lib/python3.6/site-packages/paho/mqtt/client.py", line 936, in connect
    bind_address, bind_port, clean_start, properties)
  File "/usr/lib/rhasspy-voltron/.venv/lib/python3.6/site-packages/paho/mqtt/client.py", line 1002, in connect_async
    if port <= 0:
TypeError: '<=' not supported between instances of 'str' and 'int'
[DEBUG:1542587] rhasspyserver_hermes: Connecting to 192.168.192.29:1891 (retries: 1)
[ERROR:1541585] rhasspyserver_hermes: mqtt connect
Traceback (most recent call last):
  File "/usr/lib/rhasspy-voltron/rhasspy-server-hermes/rhasspyserver_hermes/__init__.py", line 217, in start
    self.client.connect(self.host, self.port)
  File "/usr/lib/rhasspy-voltron/.venv/lib/python3.6/site-packages/paho/mqtt/client.py", line 936, in connect
    bind_address, bind_port, clean_start, properties)
  File "/usr/lib/rhasspy-voltron/.venv/lib/python3.6/site-packages/paho/mqtt/client.py", line 1002, in connect_async
    if port <= 0:
TypeError: '<=' not supported between instances of 'str' and 'int'
[DEBUG:1541584] rhasspyserver_hermes: Connecting to 192.168.192.29:1891 (retries: 0)
[DEBUG:1541583] rhasspyserver_hermes: Starting core
[DEBUG:1541132] rhasspyprofile.profile: Loading default profile settings from /usr/lib/rhasspy-voltron/rhasspy-profile/rhasspyprofile/profiles/defaults.json
[DEBUG:1537572] rhasspyserver_hermes: Shutting down core
[DEBUG:1537571] __main__: Restarting Rhasspy
[DEBUG:1537326] __main__: Re-generating /profiles/de/docker-compose.yml
[DEBUG:1537325] rhasspysupervisor: Intent handling disabled (system=dummy)
[DEBUG:1537315] __main__: Re-generating /profiles/de/supervisord.conf
[DEBUG:1534551] __main__: Wrote profile to /profiles/de/profile.json

This is curious (for me) because on an other Raspi with Rhasspy 2.4.18, the same MQTT-broker is reachable without problems.

I know, this is a pre-release of voltron, but I think connecting to an external MQTT-broker is essential.
Perhaps I’m doing something wrong?
Any suggestions?

I have a 2.5-prerelease setup working here with a base and satellite communicating over MQTT. I notice that you are using a non-standard MQTT port, I’m using the default one (1883). Rhasspy seems to interpret the port from the config file as a string if you use a non-standard one, while it has to be interpreted as a number.

Oh I see that @synesthesiam has already fixed it.

1 Like

Thanks @koan for your response and @synesthesiam for the quick fix.

Now the external MQTT-broker is connected and Rhasspy subscribes to the topics, but unfortunately the Rhasspy test-page seems to be “dead”.
When I press the wake-up-button, the popup “Listening for command” appears, but when I speak a command, nothing happens.

When I switch back to internal MQTT-broker, the test-page is working fine:
Rhasspy reacts even to wake-up-button and also to wakeword (snowboy.umtl).

I can reproduce this problem by switching between internal / external MQTT-Broker.

Maybe that’s because I’m using not the MQTT standard port 1883 ?
(but I definitely can not use the standard port)
As I said before: no problems with Rhasspy 2.4.18 and MQTT-port 1891.

Anyway, I’ll be patient, until final Version 2.5 is released.

Can you share some logs with the internal vs external MQTT broker?

@koan
Here are three logs:

First log:
Internal MQTT-broker activated , after saying hotword, intent is recognized:

[DEBUG:2020-03-12 19:23:59,357] rhasspyserver_hermes: -> AsrToggleOn(siteId='voltron')
[DEBUG:2020-03-12 19:23:59,355] rhasspyserver_hermes: -> HotwordToggleOn(siteId='voltron')
[DEBUG:2020-03-12 19:23:59,349] rhasspyserver_hermes: Handling AudioPlayFinished (topic=hermes/audioServer/voltron/playFinished, id=13f11d15-1a61-4541-93a1-407e24e0f5a2)
[DEBUG:2020-03-12 19:23:59,348] rhasspyserver_hermes: <- AudioPlayFinished(id='593af412-2553-482a-b2ee-7cdf21c16964', sessionId='')
[DEBUG:2020-03-12 19:23:59,347] rhasspyserver_hermes: Received 63 byte(s) on hermes/audioServer/voltron/playFinished
[ERROR:2020-03-12 19:23:58,622] __main__: 
Traceback (most recent call last):
  File "/usr/lib/rhasspy-voltron/.venv/lib/python3.6/site-packages/quart/app.py", line 1594, in full_dispatch_websocket
    result = await self.dispatch_websocket(websocket_context)
  File "/usr/lib/rhasspy-voltron/.venv/lib/python3.6/site-packages/quart/app.py", line 1639, in dispatch_websocket
    return await handler(**websocket_.view_args)
  File "/usr/lib/rhasspy-voltron/rhasspy-server-hermes/rhasspyserver_hermes/__main__.py", line 1766, in wrapper
    return await func(queue, *_args, **kwargs)
  File "/usr/lib/rhasspy-voltron/rhasspy-server-hermes/rhasspyserver_hermes/__main__.py", line 1890, in api_ws_intent
    message = await queue.get()
  File "/usr/lib/python3.6/asyncio/queues.py", line 167, in get
    yield from getter
concurrent.futures._base.CancelledError
[DEBUG:2020-03-12 19:23:58,619] __main__: Sent 402 char(s) to websocket
[DEBUG:2020-03-12 19:23:58,616] __main__: Sent 402 char(s) to websocket
[DEBUG:2020-03-12 19:23:58,616] rhasspyserver_hermes: Handling NluIntent (topic=hermes/intent/Zeit, id=a8479673-7d0f-41d7-ae66-4886ca3e290b)
[DEBUG:2020-03-12 19:23:58,615] rhasspyserver_hermes: Handling NluIntent (topic=hermes/intent/Zeit, id=ad38950f-8596-480c-b5be-4013d9568e1f)
[DEBUG:2020-03-12 19:23:58,614] rhasspyserver_hermes: Handling NluIntent (topic=hermes/intent/Zeit, id=e6d0c31f-3f4e-4da2-b865-af2011230eb6)
[DEBUG:2020-03-12 19:23:58,613] rhasspyserver_hermes: <- NluIntent(input='wie spät ist es', intent=Intent(intentName='Zeit', confidenceScore=1.0), slots=[Slot(entity='state', slotName='state', confidence=1, raw_value='spät', value='spät', range=SlotRange(start=4, end=8, raw_start=4, raw_end=8))], id='', siteId='voltron', sessionId='voltron-default-2d57ec6f-a8ef-4210-93b3-33c24e8b3965', customData='', asrTokens=['wie', 'spät', 'ist', 'es'], asrConfidence=1.0, wakewordId='default', rawAsrTokens=['wie', 'spät', 'ist', 'es'])
[DEBUG:2020-03-12 19:23:58,612] rhasspyserver_hermes: Received 536 byte(s) on hermes/intent/Zeit
[DEBUG:2020-03-12 19:23:58,567] rhasspyserver_hermes: <- AudioPlayBytes(119908 byte(s))
[DEBUG:2020-03-12 19:23:58,567] rhasspyserver_hermes: Received 119908 byte(s) on hermes/audioServer/voltron/playBytes/593af412-2553-482a-b2ee-7cdf21c16964

Second log:
External MQTT-broker activated and just restarted Rhasspy:

[DEBUG:2020-03-12 19:25:25,349] rhasspyprofile.download: speech_to_text.pocketsphinx.mix_weight >0 0 = False
[DEBUG:2020-03-12 19:25:25,348] rhasspyprofile.download: speech_to_text.kaldi.open_transcription True False = False
[DEBUG:2020-03-12 19:25:25,347] rhasspyprofile.download: speech_to_text.pocketsphinx.open_transcription True False = False
[DEBUG:2020-03-12 19:25:25,347] rhasspyprofile.download: Skipping kaldi/model/ivectors_test_hires/conf/splice.conf (/profiles/de/kaldi/model/ivectors_test_hires/conf/splice.conf)
[DEBUG:2020-03-12 19:25:25,346] rhasspyprofile.download: Skipping kaldi/model/ivectors_test_hires/conf/ivector_extractor.conf (/profiles/de/kaldi/model/ivectors_test_hires/conf/ivector_extractor.conf)
[DEBUG:2020-03-12 19:25:25,346] rhasspyprofile.download: Skipping kaldi/model/ivectors_test_hires/conf/online_cmvn.conf (/profiles/de/kaldi/model/ivectors_test_hires/conf/online_cmvn.conf)
[DEBUG:2020-03-12 19:25:25,345] rhasspyprofile.download: Skipping kaldi/model/extractor/final.ie (/profiles/de/kaldi/model/extractor/final.ie)
[DEBUG:2020-03-12 19:25:25,345] rhasspyprofile.download: Skipping kaldi/model/extractor/final.dubm (/profiles/de/kaldi/model/extractor/final.dubm)
[DEBUG:2020-03-12 19:25:25,344] rhasspyprofile.download: Skipping kaldi/model/extractor/splice_opts (/profiles/de/kaldi/model/extractor/splice_opts)
[DEBUG:2020-03-12 19:25:25,344] rhasspyprofile.download: Skipping kaldi/model/extractor/global_cmvn.stats (/profiles/de/kaldi/model/extractor/global_cmvn.stats)
[DEBUG:2020-03-12 19:25:25,343] rhasspyprofile.download: Skipping kaldi/model/extractor/online_cmvn.conf (/profiles/de/kaldi/model/extractor/online_cmvn.conf)
[DEBUG:2020-03-12 19:25:25,342] rhasspyprofile.download: Skipping kaldi/model/extractor/final.mat (/profiles/de/kaldi/model/extractor/final.mat)
[DEBUG:2020-03-12 19:25:25,342] rhasspyprofile.download: Skipping kaldi/model/conf/mfcc_hires.conf (/profiles/de/kaldi/model/conf/mfcc_hires.conf)
[DEBUG:2020-03-12 19:25:25,311] rhasspyprofile.download: Skipping kaldi/model/conf/mfcc.conf (/profiles/de/kaldi/model/conf/mfcc.conf)
[DEBUG:2020-03-12 19:25:25,310] rhasspyprofile.download: Skipping kaldi/model/conf/online_cmvn.conf (/profiles/de/kaldi/model/conf/online_cmvn.conf)
[DEBUG:2020-03-12 19:25:25,310] rhasspyprofile.download: Skipping kaldi/model/phones/silence_phones.txt (/profiles/de/kaldi/model/phones/silence_phones.txt)
[DEBUG:2020-03-12 19:25:25,309] rhasspyprofile.download: Skipping kaldi/model/phones/optional_silence.txt (/profiles/de/kaldi/model/phones/optional_silence.txt)
[DEBUG:2020-03-12 19:25:25,308] rhasspyprofile.download: Skipping kaldi/model/phones/extra_questions.txt (/profiles/de/kaldi/model/phones/extra_questions.txt)
[DEBUG:2020-03-12 19:25:25,308] rhasspyprofile.download: Skipping kaldi/model/phones/nonsilence_phones.txt (/profiles/de/kaldi/model/phones/nonsilence_phones.txt)
[DEBUG:2020-03-12 19:25:25,307] rhasspyprofile.download: Skipping kaldi/model/model/tree (/profiles/de/kaldi/model/model/tree)
[DEBUG:2020-03-12 19:25:25,307] rhasspyprofile.download: Skipping kaldi/model/model/final.mdl (/profiles/de/kaldi/model/model/final.mdl)
[DEBUG:2020-03-12 19:25:25,306] rhasspyprofile.download: Skipping kaldi/model/model/cmvn_opts (/profiles/de/kaldi/model/model/cmvn_opts)
[DEBUG:2020-03-12 19:25:25,306] rhasspyprofile.download: Skipping kaldi/g2p.fst (/profiles/de/kaldi/g2p.fst)
[DEBUG:2020-03-12 19:25:25,305] rhasspyprofile.download: Skipping kaldi/base_dictionary.txt (/profiles/de/kaldi/base_dictionary.txt)
[DEBUG:2020-03-12 19:25:25,304] rhasspyprofile.download: speech_to_text.system kaldi kaldi = True
[DEBUG:2020-03-12 19:25:25,304] rhasspyprofile.download: speech_to_text.system pocketsphinx kaldi = False
[DEBUG:2020-03-12 19:25:25,303] rhasspyprofile.download: wake.system precise snowboy = False
[ERROR:2020-03-12 19:25:25,148] rhasspyserver_hermes: on_message
Traceback (most recent call last):
  File "/usr/lib/rhasspy-voltron/rhasspy-server-hermes/rhasspyserver_hermes/__init__.py", line 950, in on_message
    json_payload = json.loads(msg.payload)
  File "/usr/lib/python3.6/json/__init__.py", line 354, in loads
    return _default_decoder.decode(s)
  File "/usr/lib/python3.6/json/decoder.py", line 339, in decode
    obj, end = self.raw_decode(s, idx=_w(s, 0).end())
  File "/usr/lib/python3.6/json/decoder.py", line 357, in raw_decode
    raise JSONDecodeError("Expecting value", s, err.value) from None
json.decoder.JSONDecodeError: Expecting value: line 1 column 1 (char 0)
[DEBUG:2020-03-12 19:25:25,146] rhasspyserver_hermes: Received 0 byte(s) on hermes/asr/textCaptured
[ERROR:2020-03-12 19:25:25,142] rhasspyserver_hermes: on_message
Traceback (most recent call last):
  File "/usr/lib/rhasspy-voltron/rhasspy-server-hermes/rhasspyserver_hermes/__init__.py", line 1040, in on_message
    json_payload = json.loads(msg.payload)
  File "/usr/lib/python3.6/json/__init__.py", line 354, in loads
    return _default_decoder.decode(s)
  File "/usr/lib/python3.6/json/decoder.py", line 339, in decode
    obj, end = self.raw_decode(s, idx=_w(s, 0).end())
  File "/usr/lib/python3.6/json/decoder.py", line 357, in raw_decode
    raise JSONDecodeError("Expecting value", s, err.value) from None
json.decoder.JSONDecodeError: Expecting value: line 1 column 1 (char 0)
[DEBUG:2020-03-12 19:25:25,126] rhasspyserver_hermes: Received 0 byte(s) on hermes/hotword/default/detected
[ERROR:2020-03-12 19:25:25,117] rhasspyserver_hermes: on_message
Traceback (most recent call last):
  File "/usr/lib/rhasspy-voltron/rhasspy-server-hermes/rhasspyserver_hermes/__init__.py", line 1040, in on_message
    json_payload = json.loads(msg.payload)
  File "/usr/lib/python3.6/json/__init__.py", line 354, in loads
    return _default_decoder.decode(s)
  File "/usr/lib/python3.6/json/decoder.py", line 339, in decode
    obj, end = self.raw_decode(s, idx=_w(s, 0).end())
  File "/usr/lib/python3.6/json/decoder.py", line 357, in raw_decode
    raise JSONDecodeError("Expecting value", s, err.value) from None
json.decoder.JSONDecodeError: Expecting value: line 1 column 1 (char 0)
[DEBUG:2020-03-12 19:25:25,115] rhasspyserver_hermes: Received 0 byte(s) on hermes/hotword/default/detected
[DEBUG:2020-03-12 19:25:25,109] rhasspyserver_hermes: <- AsrAudioCaptured(0 byte(s))
[DEBUG:2020-03-12 19:25:25,107] rhasspyserver_hermes: Received 0 byte(s) on rhasspy/asr/voltron/voltron/audioCaptured
[ERROR:2020-03-12 19:25:25,068] rhasspyserver_hermes: on_message
Traceback (most recent call last):
  File "/usr/lib/rhasspy-voltron/rhasspy-server-hermes/rhasspyserver_hermes/__init__.py", line 926, in on_message
    json_payload = json.loads(msg.payload)
  File "/usr/lib/python3.6/json/__init__.py", line 354, in loads
    return _default_decoder.decode(s)
  File "/usr/lib/python3.6/json/decoder.py", line 339, in decode
    obj, end = self.raw_decode(s, idx=_w(s, 0).end())
  File "/usr/lib/python3.6/json/decoder.py", line 357, in raw_decode
    raise JSONDecodeError("Expecting value", s, err.value) from None
json.decoder.JSONDecodeError: Expecting value: line 1 column 1 (char 0)
[DEBUG:2020-03-12 19:25:25,067] rhasspyserver_hermes: Received 0 byte(s) on hermes/nlu/intentNotRecognized
[DEBUG:2020-03-12 19:25:25,058] rhasspyserver_hermes: Subscribed to hermes/asr/textCaptured
[DEBUG:2020-03-12 19:25:25,056] rhasspyserver_hermes: Subscribed to hermes/hotword/+/detected
[DEBUG:2020-03-12 19:25:25,052] rhasspyserver_hermes: Subscribed to hermes/intent/#
[DEBUG:2020-03-12 19:25:25,048] rhasspyserver_hermes: Subscribed to rhasspy/asr/voltron/voltron/audioCaptured
[INFO:2020-03-12 19:25:25,042] __main__: Started
[DEBUG:2020-03-12 19:25:25,041] rhasspyserver_hermes: Subscribed to hermes/nlu/intentNotRecognized
[DEBUG:2020-03-12 19:25:24,031] rhasspyserver_hermes: Connecting to 192.168.192.29:1891 (retries: 0)
[DEBUG:2020-03-12 19:25:24,030] rhasspyserver_hermes: Starting core
[DEBUG:2020-03-12 19:25:24,027] rhasspyprofile.profile: Loading default profile settings from /usr/lib/rhasspy-voltron/rhasspy-profile/rhasspyprofile/profiles/defaults.json
[DEBUG:2020-03-12 19:25:24,026] rhasspyprofile.profile: Loading /profiles/de/profile.json
[DEBUG:2020-03-12 19:25:24,024] rhasspyprofile.profile: Loading /usr/lib/rhasspy-voltron/rhasspy-profile/rhasspyprofile/profiles/de/profile.json
[DEBUG:2020-03-12 19:25:23,995] rhasspyserver_hermes: Shutting down core
[DEBUG:2020-03-12 19:25:23,994] __main__: Restarting Rhasspy
[DEBUG:2020-03-12 19:25:23,743] __main__: Re-generating /profiles/de/docker-compose.yml
[DEBUG:2020-03-12 19:25:23,740] rhasspysupervisor: Intent handling disabled (system=dummy)
[DEBUG:2020-03-12 19:25:23,726] __main__: Re-generating /profiles/de/supervisord.conf
[DEBUG:2020-03-12 19:25:23,724] rhasspyprofile.profile: Loading /profiles/de/profile.json
[DEBUG:2020-03-12 19:25:23,721] rhasspyprofile.profile: Loading /usr/lib/rhasspy-voltron/rhasspy-profile/rhasspyprofile/profiles/de/profile.json
[DEBUG:2020-03-12 19:25:23,712] __main__: Wrote profile to /profiles/de/profile.json

Third log:
External MQTT-broker is still activated and wake-up-button was pressed
-> popup “Listening for command” appears, but no reaction after speaking
-> after timeout? popup “Listening for command” is closed

[ERROR:2020-03-12 19:27:26,839] rhasspyserver_hermes: on_message
Traceback (most recent call last):
  File "/usr/lib/rhasspy-voltron/rhasspy-server-hermes/rhasspyserver_hermes/__init__.py", line 950, in on_message
    json_payload = json.loads(msg.payload)
  File "/usr/lib/python3.6/json/__init__.py", line 354, in loads
    return _default_decoder.decode(s)
  File "/usr/lib/python3.6/json/decoder.py", line 339, in decode
    obj, end = self.raw_decode(s, idx=_w(s, 0).end())
  File "/usr/lib/python3.6/json/decoder.py", line 357, in raw_decode
    raise JSONDecodeError("Expecting value", s, err.value) from None
json.decoder.JSONDecodeError: Expecting value: line 1 column 1 (char 0)
[DEBUG:2020-03-12 19:27:26,838] rhasspyserver_hermes: Received 0 byte(s) on hermes/asr/textCaptured
[ERROR:2020-03-12 19:27:26,832] rhasspyserver_hermes: on_message
Traceback (most recent call last):
  File "/usr/lib/rhasspy-voltron/rhasspy-server-hermes/rhasspyserver_hermes/__init__.py", line 1040, in on_message
    json_payload = json.loads(msg.payload)
  File "/usr/lib/python3.6/json/__init__.py", line 354, in loads
    return _default_decoder.decode(s)
  File "/usr/lib/python3.6/json/decoder.py", line 339, in decode
    obj, end = self.raw_decode(s, idx=_w(s, 0).end())
  File "/usr/lib/python3.6/json/decoder.py", line 357, in raw_decode
    raise JSONDecodeError("Expecting value", s, err.value) from None
json.decoder.JSONDecodeError: Expecting value: line 1 column 1 (char 0)
[DEBUG:2020-03-12 19:27:26,831] rhasspyserver_hermes: Received 0 byte(s) on hermes/hotword/default/detected
[ERROR:2020-03-12 19:27:26,825] rhasspyserver_hermes: on_message
Traceback (most recent call last):
  File "/usr/lib/rhasspy-voltron/rhasspy-server-hermes/rhasspyserver_hermes/__init__.py", line 1040, in on_message
    json_payload = json.loads(msg.payload)
  File "/usr/lib/python3.6/json/__init__.py", line 354, in loads
    return _default_decoder.decode(s)
  File "/usr/lib/python3.6/json/decoder.py", line 339, in decode
    obj, end = self.raw_decode(s, idx=_w(s, 0).end())
  File "/usr/lib/python3.6/json/decoder.py", line 357, in raw_decode
    raise JSONDecodeError("Expecting value", s, err.value) from None
json.decoder.JSONDecodeError: Expecting value: line 1 column 1 (char 0)
[DEBUG:2020-03-12 19:27:26,824] rhasspyserver_hermes: Received 0 byte(s) on hermes/hotword/default/detected
[DEBUG:2020-03-12 19:27:26,819] rhasspyserver_hermes: <- AsrAudioCaptured(0 byte(s))
[DEBUG:2020-03-12 19:27:26,818] rhasspyserver_hermes: Received 0 byte(s) on rhasspy/asr/voltron/voltron/audioCaptured
[ERROR:2020-03-12 19:27:26,800] rhasspyserver_hermes: on_message
Traceback (most recent call last):
  File "/usr/lib/rhasspy-voltron/rhasspy-server-hermes/rhasspyserver_hermes/__init__.py", line 926, in on_message
    json_payload = json.loads(msg.payload)
  File "/usr/lib/python3.6/json/__init__.py", line 354, in loads
    return _default_decoder.decode(s)
  File "/usr/lib/python3.6/json/decoder.py", line 339, in decode
    obj, end = self.raw_decode(s, idx=_w(s, 0).end())
  File "/usr/lib/python3.6/json/decoder.py", line 357, in raw_decode
    raise JSONDecodeError("Expecting value", s, err.value) from None
json.decoder.JSONDecodeError: Expecting value: line 1 column 1 (char 0)
[DEBUG:2020-03-12 19:27:26,799] rhasspyserver_hermes: Received 0 byte(s) on hermes/nlu/intentNotRecognized
[DEBUG:2020-03-12 19:27:26,793] rhasspyserver_hermes: Subscribed to hermes/asr/textCaptured
[DEBUG:2020-03-12 19:27:26,791] rhasspyserver_hermes: Subscribed to hermes/hotword/+/detected
[DEBUG:2020-03-12 19:27:26,789] rhasspyserver_hermes: Subscribed to hermes/intent/#
[DEBUG:2020-03-12 19:27:26,787] rhasspyserver_hermes: Subscribed to rhasspy/asr/voltron/voltron/audioCaptured
[DEBUG:2020-03-12 19:27:26,785] rhasspyserver_hermes: Subscribed to hermes/nlu/intentNotRecognized
[ERROR:2020-03-12 19:27:13,748] __main__: 
Traceback (most recent call last):
  File "/usr/lib/rhasspy-voltron/.venv/lib/python3.6/site-packages/quart/app.py", line 1471, in full_dispatch_request
    result = await self.dispatch_request(request_context)
  File "/usr/lib/rhasspy-voltron/.venv/lib/python3.6/site-packages/quart/app.py", line 1519, in dispatch_request
    return await handler(**request_.view_args)
  File "/usr/lib/rhasspy-voltron/rhasspy-server-hermes/rhasspyserver_hermes/__main__.py", line 748, in api_listen_for_command
    async for response in core.publish_wait(handle_captured(), messages, topics):
  File "/usr/lib/rhasspy-voltron/rhasspy-server-hermes/rhasspyserver_hermes/__init__.py", line 837, in publish_wait
    _, result = await asyncio.wait_for(result_awaitable, timeout_seconds)
  File "/usr/lib/python3.6/asyncio/tasks.py", line 362, in wait_for
    raise futures.TimeoutError()
concurrent.futures._base.TimeoutError
[DEBUG:2020-03-12 19:26:43,715] rhasspyserver_hermes: -> AsrStartListening(siteId='voltron', sessionId='8f864bbc-3e49-4760-a380-2ffcb1ca944f', stopOnSilence=True, sendAudioCaptured=True, wakewordId='')
[DEBUG:2020-03-12 19:26:43,714] rhasspyserver_hermes: Subscribed to hermes/error/asr
[DEBUG:2020-03-12 19:26:43,713] __main__: Waiting for transcription (sessionId=8f864bbc-3e49-4760-a380-2ffcb1ca944f)

Hope, this helps?

Mmmm I’m not sure what is happening here… I can’t replicate this in my setup either.

Doesn’t matter, thanks anyway for trying to help.
I’ll wait for the final release of Voltron.

Thanks for the logs, @Jorg_Baumann. I’m hoping this is one of those errors that will magically disappear in the next release (building now) :slight_smile:

@synesthesiam
Hi,
sorry, that I wasn’t patient, I pulled the latest pre-release once again, but the magician was not present :smile:

But i did a new test:
I’ve installed a MOSQUITTO-broker with standard MQTT-port 1883 on the same machine, where the other MQTT-broker with MQTT-port 1891 causes problems:

With connection to MOSQUITTO (1883), Rhasspy works fine.
With connection to the other Broker (1891), Rhasspy does not respond to commands.

Here are two logs:
First log with connection to MOSQUITTO, Port 1883, Rhasspy works

[DEBUG:2020-03-13 12:04:46,926] rhasspyprofile.download: speech_to_text.pocketsphinx.mix_weight >0 0 = False
[DEBUG:2020-03-13 12:04:46,925] rhasspyprofile.download: speech_to_text.kaldi.open_transcription True False = False
[DEBUG:2020-03-13 12:04:46,925] rhasspyprofile.download: speech_to_text.pocketsphinx.open_transcription True False = False
[DEBUG:2020-03-13 12:04:46,924] rhasspyprofile.download: Skipping kaldi/model/ivectors_test_hires/conf/splice.conf (/profiles/de/kaldi/model/ivectors_test_hires/conf/splice.conf)
[DEBUG:2020-03-13 12:04:46,923] rhasspyprofile.download: Skipping kaldi/model/ivectors_test_hires/conf/ivector_extractor.conf (/profiles/de/kaldi/model/ivectors_test_hires/conf/ivector_extractor.conf)
[DEBUG:2020-03-13 12:04:46,922] rhasspyprofile.download: Skipping kaldi/model/ivectors_test_hires/conf/online_cmvn.conf (/profiles/de/kaldi/model/ivectors_test_hires/conf/online_cmvn.conf)
[DEBUG:2020-03-13 12:04:46,921] rhasspyprofile.download: Skipping kaldi/model/extractor/final.ie (/profiles/de/kaldi/model/extractor/final.ie)
[DEBUG:2020-03-13 12:04:46,921] rhasspyprofile.download: Skipping kaldi/model/extractor/final.dubm (/profiles/de/kaldi/model/extractor/final.dubm)
[DEBUG:2020-03-13 12:04:46,920] rhasspyprofile.download: Skipping kaldi/model/extractor/splice_opts (/profiles/de/kaldi/model/extractor/splice_opts)
[DEBUG:2020-03-13 12:04:46,919] rhasspyprofile.download: Skipping kaldi/model/extractor/global_cmvn.stats (/profiles/de/kaldi/model/extractor/global_cmvn.stats)
[DEBUG:2020-03-13 12:04:46,919] rhasspyprofile.download: Skipping kaldi/model/extractor/online_cmvn.conf (/profiles/de/kaldi/model/extractor/online_cmvn.conf)
[DEBUG:2020-03-13 12:04:46,918] rhasspyprofile.download: Skipping kaldi/model/extractor/final.mat (/profiles/de/kaldi/model/extractor/final.mat)
[DEBUG:2020-03-13 12:04:46,917] rhasspyprofile.download: Skipping kaldi/model/conf/mfcc_hires.conf (/profiles/de/kaldi/model/conf/mfcc_hires.conf)
[DEBUG:2020-03-13 12:04:46,916] rhasspyprofile.download: Skipping kaldi/model/conf/mfcc.conf (/profiles/de/kaldi/model/conf/mfcc.conf)
[DEBUG:2020-03-13 12:04:46,916] rhasspyprofile.download: Skipping kaldi/model/conf/online_cmvn.conf (/profiles/de/kaldi/model/conf/online_cmvn.conf)
[DEBUG:2020-03-13 12:04:46,915] rhasspyprofile.download: Skipping kaldi/model/phones/silence_phones.txt (/profiles/de/kaldi/model/phones/silence_phones.txt)
[DEBUG:2020-03-13 12:04:46,914] rhasspyprofile.download: Skipping kaldi/model/phones/optional_silence.txt (/profiles/de/kaldi/model/phones/optional_silence.txt)
[DEBUG:2020-03-13 12:04:46,913] rhasspyprofile.download: Skipping kaldi/model/phones/extra_questions.txt (/profiles/de/kaldi/model/phones/extra_questions.txt)
[DEBUG:2020-03-13 12:04:46,913] rhasspyprofile.download: Skipping kaldi/model/phones/nonsilence_phones.txt (/profiles/de/kaldi/model/phones/nonsilence_phones.txt)
[DEBUG:2020-03-13 12:04:46,912] rhasspyprofile.download: Skipping kaldi/model/model/tree (/profiles/de/kaldi/model/model/tree)
[DEBUG:2020-03-13 12:04:46,897] rhasspyprofile.download: Skipping kaldi/model/model/final.mdl (/profiles/de/kaldi/model/model/final.mdl)
[DEBUG:2020-03-13 12:04:46,896] rhasspyprofile.download: Skipping kaldi/model/model/cmvn_opts (/profiles/de/kaldi/model/model/cmvn_opts)
[DEBUG:2020-03-13 12:04:46,896] rhasspyprofile.download: Skipping kaldi/g2p.fst (/profiles/de/kaldi/g2p.fst)
[DEBUG:2020-03-13 12:04:46,895] rhasspyprofile.download: Skipping kaldi/base_dictionary.txt (/profiles/de/kaldi/base_dictionary.txt)
[DEBUG:2020-03-13 12:04:46,894] rhasspyprofile.download: speech_to_text.system kaldi kaldi = True
[DEBUG:2020-03-13 12:04:46,894] rhasspyprofile.download: speech_to_text.system pocketsphinx kaldi = False
[DEBUG:2020-03-13 12:04:46,884] rhasspyprofile.download: wake.system precise snowboy = False
[DEBUG:2020-03-13 12:04:46,619] rhasspyserver_hermes: Subscribed to hermes/hotword/+/detected
[DEBUG:2020-03-13 12:04:46,618] rhasspyserver_hermes: Subscribed to rhasspy/asr/voltron/voltron/audioCaptured
[DEBUG:2020-03-13 12:04:46,616] rhasspyserver_hermes: Subscribed to hermes/asr/textCaptured
[INFO:2020-03-13 12:04:46,614] rhasspyserver_hermes: Started
[DEBUG:2020-03-13 12:04:46,613] rhasspyserver_hermes: Subscribed to hermes/intent/#
[DEBUG:2020-03-13 12:04:46,612] rhasspyserver_hermes: Subscribed to hermes/nlu/intentNotRecognized
[DEBUG:2020-03-13 12:04:45,544] rhasspyserver_hermes: Connecting to 192.168.192.29:1883 (retries: 0)
[DEBUG:2020-03-13 12:04:45,541] rhasspyserver_hermes: Starting core
[DEBUG:2020-03-13 12:04:45,536] rhasspyprofile.profile: Loading default profile settings from /usr/lib/rhasspy-voltron/rhasspy-profile/rhasspyprofile/profiles/defaults.json
[DEBUG:2020-03-13 12:04:45,534] rhasspyprofile.profile: Loading /profiles/de/profile.json
[DEBUG:2020-03-13 12:04:45,531] rhasspyprofile.profile: Loading /usr/lib/rhasspy-voltron/rhasspy-profile/rhasspyprofile/profiles/de/profile.json
[DEBUG:2020-03-13 12:04:44,908] rhasspyserver_hermes: Shutting down core
[DEBUG:2020-03-13 12:04:44,906] rhasspyserver_hermes: Restarting Rhasspy
[DEBUG:2020-03-13 12:04:44,618] rhasspyserver_hermes: Re-generating /profiles/de/docker-compose.yml
[DEBUG:2020-03-13 12:04:44,615] rhasspysupervisor: Intent handling disabled (system=dummy)
[DEBUG:2020-03-13 12:04:44,603] rhasspyserver_hermes: Re-generating /profiles/de/supervisord.conf
[DEBUG:2020-03-13 12:04:44,601] rhasspyprofile.profile: Loading /profiles/de/profile.json
[DEBUG:2020-03-13 12:04:44,597] rhasspyprofile.profile: Loading /usr/lib/rhasspy-voltron/rhasspy-profile/rhasspyprofile/profiles/de/profile.json
[DEBUG:2020-03-13 12:04:44,589] rhasspyserver_hermes: Wrote profile to /profiles/de/profile.json

Second log with connection to the other boker, Port 1891, Rhasspy does not respond to commands

[DEBUG:2020-03-13 12:06:29,068] rhasspyprofile.download: speech_to_text.pocketsphinx.mix_weight >0 0 = False
[DEBUG:2020-03-13 12:06:29,066] rhasspyprofile.download: speech_to_text.kaldi.open_transcription True False = False
[DEBUG:2020-03-13 12:06:29,066] rhasspyprofile.download: speech_to_text.pocketsphinx.open_transcription True False = False
[DEBUG:2020-03-13 12:06:29,065] rhasspyprofile.download: Skipping kaldi/model/ivectors_test_hires/conf/splice.conf (/profiles/de/kaldi/model/ivectors_test_hires/conf/splice.conf)
[DEBUG:2020-03-13 12:06:29,064] rhasspyprofile.download: Skipping kaldi/model/ivectors_test_hires/conf/ivector_extractor.conf (/profiles/de/kaldi/model/ivectors_test_hires/conf/ivector_extractor.conf)
[DEBUG:2020-03-13 12:06:29,063] rhasspyprofile.download: Skipping kaldi/model/ivectors_test_hires/conf/online_cmvn.conf (/profiles/de/kaldi/model/ivectors_test_hires/conf/online_cmvn.conf)
[DEBUG:2020-03-13 12:06:29,062] rhasspyprofile.download: Skipping kaldi/model/extractor/final.ie (/profiles/de/kaldi/model/extractor/final.ie)
[DEBUG:2020-03-13 12:06:29,046] rhasspyprofile.download: Skipping kaldi/model/extractor/final.dubm (/profiles/de/kaldi/model/extractor/final.dubm)
[DEBUG:2020-03-13 12:06:29,045] rhasspyprofile.download: Skipping kaldi/model/extractor/splice_opts (/profiles/de/kaldi/model/extractor/splice_opts)
[DEBUG:2020-03-13 12:06:29,045] rhasspyprofile.download: Skipping kaldi/model/extractor/global_cmvn.stats (/profiles/de/kaldi/model/extractor/global_cmvn.stats)
[DEBUG:2020-03-13 12:06:29,044] rhasspyprofile.download: Skipping kaldi/model/extractor/online_cmvn.conf (/profiles/de/kaldi/model/extractor/online_cmvn.conf)
[DEBUG:2020-03-13 12:06:29,043] rhasspyprofile.download: Skipping kaldi/model/extractor/final.mat (/profiles/de/kaldi/model/extractor/final.mat)
[DEBUG:2020-03-13 12:06:29,043] rhasspyprofile.download: Skipping kaldi/model/conf/mfcc_hires.conf (/profiles/de/kaldi/model/conf/mfcc_hires.conf)
[DEBUG:2020-03-13 12:06:29,042] rhasspyprofile.download: Skipping kaldi/model/conf/mfcc.conf (/profiles/de/kaldi/model/conf/mfcc.conf)
[DEBUG:2020-03-13 12:06:29,041] rhasspyprofile.download: Skipping kaldi/model/conf/online_cmvn.conf (/profiles/de/kaldi/model/conf/online_cmvn.conf)
[DEBUG:2020-03-13 12:06:29,040] rhasspyprofile.download: Skipping kaldi/model/phones/silence_phones.txt (/profiles/de/kaldi/model/phones/silence_phones.txt)
[DEBUG:2020-03-13 12:06:29,032] rhasspyprofile.download: Skipping kaldi/model/phones/optional_silence.txt (/profiles/de/kaldi/model/phones/optional_silence.txt)
[DEBUG:2020-03-13 12:06:29,031] rhasspyprofile.download: Skipping kaldi/model/phones/extra_questions.txt (/profiles/de/kaldi/model/phones/extra_questions.txt)
[DEBUG:2020-03-13 12:06:29,031] rhasspyprofile.download: Skipping kaldi/model/phones/nonsilence_phones.txt (/profiles/de/kaldi/model/phones/nonsilence_phones.txt)
[DEBUG:2020-03-13 12:06:29,030] rhasspyprofile.download: Skipping kaldi/model/model/tree (/profiles/de/kaldi/model/model/tree)
[DEBUG:2020-03-13 12:06:29,029] rhasspyprofile.download: Skipping kaldi/model/model/final.mdl (/profiles/de/kaldi/model/model/final.mdl)
[DEBUG:2020-03-13 12:06:29,028] rhasspyprofile.download: Skipping kaldi/model/model/cmvn_opts (/profiles/de/kaldi/model/model/cmvn_opts)
[DEBUG:2020-03-13 12:06:29,028] rhasspyprofile.download: Skipping kaldi/g2p.fst (/profiles/de/kaldi/g2p.fst)
[DEBUG:2020-03-13 12:06:29,027] rhasspyprofile.download: Skipping kaldi/base_dictionary.txt (/profiles/de/kaldi/base_dictionary.txt)
[DEBUG:2020-03-13 12:06:29,026] rhasspyprofile.download: speech_to_text.system kaldi kaldi = True
[DEBUG:2020-03-13 12:06:29,025] rhasspyprofile.download: speech_to_text.system pocketsphinx kaldi = False
[DEBUG:2020-03-13 12:06:29,025] rhasspyprofile.download: wake.system precise snowboy = False
[ERROR:2020-03-13 12:06:28,834] rhasspyserver_hermes: on_message
Traceback (most recent call last):
  File "/usr/lib/rhasspy-voltron/rhasspy-server-hermes/rhasspyserver_hermes/__init__.py", line 1041, in on_message
    json_payload = json.loads(msg.payload)
  File "/usr/lib/python3.6/json/__init__.py", line 354, in loads
    return _default_decoder.decode(s)
  File "/usr/lib/python3.6/json/decoder.py", line 339, in decode
    obj, end = self.raw_decode(s, idx=_w(s, 0).end())
  File "/usr/lib/python3.6/json/decoder.py", line 357, in raw_decode
    raise JSONDecodeError("Expecting value", s, err.value) from None
json.decoder.JSONDecodeError: Expecting value: line 1 column 1 (char 0)
[DEBUG:2020-03-13 12:06:28,832] rhasspyserver_hermes: Received 0 byte(s) on hermes/hotword/default/detected
[DEBUG:2020-03-13 12:06:28,829] rhasspyserver_hermes: <- AsrAudioCaptured(0 byte(s))
[DEBUG:2020-03-13 12:06:28,828] rhasspyserver_hermes: Received 0 byte(s) on rhasspy/asr/voltron/voltron/audioCaptured
[ERROR:2020-03-13 12:06:28,825] rhasspyserver_hermes: on_message
Traceback (most recent call last):
  File "/usr/lib/rhasspy-voltron/rhasspy-server-hermes/rhasspyserver_hermes/__init__.py", line 950, in on_message
    json_payload = json.loads(msg.payload)
  File "/usr/lib/python3.6/json/__init__.py", line 354, in loads
    return _default_decoder.decode(s)
  File "/usr/lib/python3.6/json/decoder.py", line 339, in decode
    obj, end = self.raw_decode(s, idx=_w(s, 0).end())
  File "/usr/lib/python3.6/json/decoder.py", line 357, in raw_decode
    raise JSONDecodeError("Expecting value", s, err.value) from None
json.decoder.JSONDecodeError: Expecting value: line 1 column 1 (char 0)
[DEBUG:2020-03-13 12:06:28,824] rhasspyserver_hermes: Received 0 byte(s) on hermes/asr/textCaptured
[ERROR:2020-03-13 12:06:28,819] rhasspyserver_hermes: on_message
Traceback (most recent call last):
  File "/usr/lib/rhasspy-voltron/rhasspy-server-hermes/rhasspyserver_hermes/__init__.py", line 1041, in on_message
    json_payload = json.loads(msg.payload)
  File "/usr/lib/python3.6/json/__init__.py", line 354, in loads
    return _default_decoder.decode(s)
  File "/usr/lib/python3.6/json/decoder.py", line 339, in decode
    obj, end = self.raw_decode(s, idx=_w(s, 0).end())
  File "/usr/lib/python3.6/json/decoder.py", line 357, in raw_decode
    raise JSONDecodeError("Expecting value", s, err.value) from None
json.decoder.JSONDecodeError: Expecting value: line 1 column 1 (char 0)
[DEBUG:2020-03-13 12:06:28,818] rhasspyserver_hermes: Received 0 byte(s) on hermes/hotword/default/detected
[ERROR:2020-03-13 12:06:28,759] rhasspyserver_hermes: on_message
Traceback (most recent call last):
  File "/usr/lib/rhasspy-voltron/rhasspy-server-hermes/rhasspyserver_hermes/__init__.py", line 926, in on_message
    json_payload = json.loads(msg.payload)
  File "/usr/lib/python3.6/json/__init__.py", line 354, in loads
    return _default_decoder.decode(s)
  File "/usr/lib/python3.6/json/decoder.py", line 339, in decode
    obj, end = self.raw_decode(s, idx=_w(s, 0).end())
  File "/usr/lib/python3.6/json/decoder.py", line 357, in raw_decode
    raise JSONDecodeError("Expecting value", s, err.value) from None
json.decoder.JSONDecodeError: Expecting value: line 1 column 1 (char 0)
[DEBUG:2020-03-13 12:06:28,757] rhasspyserver_hermes: Received 0 byte(s) on hermes/nlu/intentNotRecognized
[DEBUG:2020-03-13 12:06:28,726] rhasspyserver_hermes: Subscribed to hermes/hotword/+/detected
[DEBUG:2020-03-13 12:06:28,724] rhasspyserver_hermes: Subscribed to rhasspy/asr/voltron/voltron/audioCaptured
[DEBUG:2020-03-13 12:06:28,722] rhasspyserver_hermes: Subscribed to hermes/asr/textCaptured
[DEBUG:2020-03-13 12:06:28,713] rhasspyserver_hermes: Subscribed to hermes/intent/#
[INFO:2020-03-13 12:06:28,712] rhasspyserver_hermes: Started
[DEBUG:2020-03-13 12:06:28,709] rhasspyserver_hermes: Subscribed to hermes/nlu/intentNotRecognized
[DEBUG:2020-03-13 12:06:27,660] rhasspyserver_hermes: Connecting to 192.168.192.29:1891 (retries: 0)
[DEBUG:2020-03-13 12:06:27,658] rhasspyserver_hermes: Starting core
[DEBUG:2020-03-13 12:06:27,656] rhasspyprofile.profile: Loading default profile settings from /usr/lib/rhasspy-voltron/rhasspy-profile/rhasspyprofile/profiles/defaults.json
[DEBUG:2020-03-13 12:06:27,655] rhasspyprofile.profile: Loading /profiles/de/profile.json
[DEBUG:2020-03-13 12:06:27,653] rhasspyprofile.profile: Loading /usr/lib/rhasspy-voltron/rhasspy-profile/rhasspyprofile/profiles/de/profile.json
[DEBUG:2020-03-13 12:06:27,583] rhasspyserver_hermes: Shutting down core
[DEBUG:2020-03-13 12:06:27,582] rhasspyserver_hermes: Restarting Rhasspy
[DEBUG:2020-03-13 12:06:27,275] rhasspyserver_hermes: Re-generating /profiles/de/docker-compose.yml
[DEBUG:2020-03-13 12:06:27,272] rhasspysupervisor: Intent handling disabled (system=dummy)
[DEBUG:2020-03-13 12:06:27,261] rhasspyserver_hermes: Re-generating /profiles/de/supervisord.conf
[DEBUG:2020-03-13 12:06:27,259] rhasspyprofile.profile: Loading /profiles/de/profile.json
[DEBUG:2020-03-13 12:06:27,255] rhasspyprofile.profile: Loading /usr/lib/rhasspy-voltron/rhasspy-profile/rhasspyprofile/profiles/de/profile.json
[DEBUG:2020-03-13 12:06:27,249] rhasspyserver_hermes: Wrote profile to /profiles/de/profile.json

In the second log, I can see a message:

File “/usr/lib/python3.6/json/decoder.py”, line 357, in raw_decode
raise JSONDecodeError(“Expecting value”, s, err.value) from None

I don’t know if that’s the reason of the problem.

But IMHO the problem is still related to the external port 1891, because with external port 1883 everything is OK.

I need to add some better logging, but thanks for trying it!

The error suggests an empty or malformed message is getting in on one of the subscribed topics. Does the second port have encrypted payloads or something?

@synesthesiam
No, the port 1891 has nothing special like encryption or other things.
As I said, it is working well from another Raspi with Rhasspy V 2.4.19

Hello everybody! I am wondering how to best handle the MQTT Broker, as I already use a broker under the standard port with password protection for my smart home devices via HomeAssistant.
When I used Snips back then and used this Broker for Snips as well, it was flooded by Snips so much that the Smart Home control by HomeAssistant didn’t work properly anymore. The solution was to build snips on a separate device with a separate broker and a MQTT bridge:

connection snipsmqtt
address IP:PORT
remote_username USERNAME
remote_password PASSWORD
remote_clientid snips
start_type automatic
notifications true
cleansession true
bridge_protocol_version mqttv311

# default setting but we explicitly set it here
try_private true

topic hermes/dialogueManager/# in
topic hermes/asr/# in
topic hermes/hotword/# out

topic hermes/intent/# out
topic hermes/asr/# out
topic hermes/hotword/# out
topic hermes/nlu/# out

topic hermes/tts/say in
topic hermes/audioServer/# in
topic hermes/tts/sayFinished in

For Rhasspy version 2.5 I would rather use all Docker images (HA, Rhasspy) on one device. In this case it should work if Rhasspy brings a second MQTT broker with a different port and I connect both brokers with a bridge, right?
Alternative: Maybe Rhasspy will not send so many messages and I can use the current broker. Would it be possible to use my current broker for Rhasspy 2.5, since it requires authentication?
Does it make sense that I test this with the (pre-)^2 release, or is it too early for that?

I wanted to checkout a prereleased V2.5 on github… Actually I’m having a hard time to find it. Can I just clone this repo: V2.5?

Thanks

EDIT: I think I’ve found it --> install docs

I’m stuck at installing the docker image with the following error message:

Does anyone faced the same issue?

For me it’s working with this command:
docker run -d -p 12101:12101 --restart unless-stopped -v "$HOME/.config/rhasspy/profiles:/profiles" --device /dev/snd:/dev/snd rhasspy/rhasspy:2.5.0-pre --user-profiles /profiles --profile de

Perhaps there are too much spaces in your command ?

Nope. I’ve thought of this as well and tried it.

Still the same error.