Documentation Preview for 2.5

synesthesiam · February 17, 2020, 3:44am

I know many Rhasspians are patiently waiting for version 2.5. It’s not ready just yet , but I wanted to give everyone a peek at the new docs and web UI screenshots. These links will change when 2.5 is released!

If anything, take a look at all of the MQTT services and the sheer size of the MQTT API that will be supported. I hope this will help people appreciate why this is taking so long Big thanks to @maxbachmann and @koan for creating Github build scripts and tests

In the next few weeks, I’d like to release a preview 2.5 Docker image for the community to start testing. I expect there to be a lot of bugs initially, since this is essentially a complete rewrite of Rhasspy! But my hope is that having the code split across many services will make it easier for people to contribute. Ideally, there will be volunteers to “adopt” some of the services and help me keep focused on new features.

I appreciate everyone’s patience, and I’m excited to be able to build something that people value

KiboOst · February 17, 2020, 9:47am

Having the doc even before the software itself, amazing work dudes !

Many thanks for such devotion

FredTheFrog · February 17, 2020, 11:07am

I’m one of those “patient waiters”. I probably won’t jump right into 2.5, but instead wait for 2.5.3 or 2.5.4, knowing there’s bound to be some wrinkles along the way. That’s not to say I’m a pessimist. It’s a realistic opinion based on years of software employment. Now, I’ve been EXTREMELY pleased with Rhasspy 2.4.x so far, and I expect I will be UNBELIEVABLY happy with the new 2.5 releases.

@synesthesiam, @koan, @maxbachmann, and all the others who generously contribute: take your time, double- and triple-check your efforts. Don’t simply look for errors, look for opportunities to improve the functionality, reliability, and readability of the project. Getting preliminary documentation out like this is an EXCELLENT way to begin moving forward. Cheers to all of you, and as I’ve previously proposed to @synesthesiam, allow me to offer you all a donation of beer, coffee, pizza, or whatever material thing fuels your development passions. You’re all the greatest, and Rhasspy is truly something wonderful.

synesthesiam · February 18, 2020, 3:44am

For me, a lot of this comes down to the documentation and what users see out of the box. I’m trying to simplify the web UI a bit in 2.5, as well as sprinkle in relevant doc links everywhere. If I can get mkdocs to do what I want, I plan to just embed the entire Rhasspy docs into the web UI

I also know that @fastjack has some great ideas about extending Rhasspy’s functionality, specifically with Snips-like entities in Kaldi. I was hoping to have implemented some of that by now, but there’s been so much to do just in the infrastructure.

Beer mostly, I love a good dark Belgian ale I really do appreciate the thought; I’ve not taken donations yet just to avoid any kind of work-related conflict. I would be very interested to hear if anyone’s got a way to have money go directly into a hosting account like Digital Ocean (which runs this site). I don’t mind paying for the droplet, but I think it’d be awesome to have the community site self-sustaining.

You’re welcome! I’m very happy to be doing something like this

FredTheFrog · February 18, 2020, 11:54am

I was fortunate enough to work for a Belgian company for three years and make two visits to the home office. The variety and abundance of local beers there was astounding. Does Digital Ocean accept pints of ale?

Andrew49 · February 18, 2020, 3:23pm

Thanks for the very comprehensive preview of 2.5. I can see that a huge amount of work has gone and is going into it. Thanks for all your effort.
I’m looking forward to giving it a try when it’s ready!

Bozor · February 18, 2020, 6:47pm

@synesthesiam this looks absolutely amazing. Thanks a lot for this awesome work. Any way to help to wrap up things? Do you need any testers or something else?

Thumbs up.

thomas_cologne · February 18, 2020, 8:29pm

Just one remark so far: I am missing the index at the “new docs”. Will that be included in the future?
For me the current table of content is very helpful

synesthesiam · February 18, 2020, 9:21pm

Yes! That’s part of the readthedocs template, but GitHub pages does not seem to pay attention to it. I too need the sidebar to properly navigate the docs

synesthesiam · February 18, 2020, 9:22pm

Definitely When the preview release goes out, I’d appreciate folks trying it out and submitting Github issues. There will also be a few services missing initially, so I may see if anyone wants to write them.

KiboOst · February 18, 2020, 9:32pm

I have a pi4 and a pi0 waiting for testing.
Still not in production so I can break it. Will also test and enhance jeedom plugin with it.
Hope turning all that in production soon once both rhasspy 2.5 and jeedom plugin are fully features and robust

frkos · February 19, 2020, 7:26pm

Good news!)
Will be glad to test hassio addon

KiboOst · February 28, 2020, 10:36pm

Just having a look at 2.5 commits, the documentation, web interface … wow ! Dudes, you are making impressive work Very professional, can’t wait to put my hand on this (yes, seems we can install it now, but I promise to be patient )

That’s all, just wanted to Rhasspy dev team.

KiboOst · March 1, 2020, 1:04pm

@synesthesiam Does anyone of dev team tried HermesLedControl with v2.5 to validate all needed mqtt topics ?

synesthesiam · March 1, 2020, 8:54pm

Thanks! I’m very happy with how it’s all coming together. A bit later than I was planning, but that’s life I guess

I don’t think anyone’s tested it yet, but looking at this file all of the topics at the top are supported (I assume the hermes/led and hermes/volume topics are specific to this project?)

KiboOst · March 2, 2020, 8:52am

Yes I think all hermes/leds/ and volume are custom to HLC

Can’t wait to test 2.5 !
If leds works and we can easily get docker base and satellite(pi0) running, I will switch it to prod soon

Once both 2.5 and jeedom plugin are ready for production, I may add a few words on jeedom plugin in the doc, if you agree.

paddsen · March 7, 2020, 6:40am

Yesterday I did some testing with your voltron (2.5) source. Really hard build at the moment, but exactly what I was thinking about when searching for a snips successor.
I was able to build the hermes-wake-snowboy part with hermes-microphone-pyaudio and attach it to hermes-led-control. Alltogether it is already working with my testing rhasspy 2.4.18 central server.
Audio is being played by Sonos as I do with my running snips. (Yes, I know… Sonos But those old speakers sound really good, and the new Ikea ones are cheap)
Quite a hack and more like Frankenstein‘s Monster More containers and venvs a single man can stand

Is there planning for satellite wake-word detection with publishing the audio to MQTT „after“ detection? Atm I was only able to stream all the time via MQTT, just like it was with snips before their latest release.

Keep up the great work! I am really hyped for 2.5!

paddsen · March 7, 2020, 6:41am

@KiboOst testing done! Works fine.

maxbachmann · March 7, 2020, 9:03am

That is actually something we just talked about yesterday and @synesthesiam added a first commit to address this https://github.com/rhasspy/rhasspy-wake-porcupine-hermes/commits/master a couple of hours ago
So it will be both possible to permanently stream and to stream only after the wakeword was detected

paddsen · March 7, 2020, 10:50am

Great! So I will test the new bulid in the evening

maxbachmann · March 7, 2020, 12:12pm

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

paddsen · March 7, 2020, 5:35pm

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!

synesthesiam · March 8, 2020, 2:42am

Very glad to see folks giving the code a try 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!

paddsen · March 8, 2020, 6:02pm

@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

synesthesiam · March 8, 2020, 7:46pm

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.”

Jorg_Baumann · March 11, 2020, 10:12pm

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?

koan · March 12, 2020, 8:24am

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.

Jorg_Baumann · March 12, 2020, 6:40pm

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.

koan · March 12, 2020, 6:54pm

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

Jorg_Baumann · March 12, 2020, 7:53pm

@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?

koan · March 12, 2020, 8:17pm

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

Jorg_Baumann · March 12, 2020, 8:24pm

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

synesthesiam · March 12, 2020, 8:45pm

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)

Jorg_Baumann · March 13, 2020, 12:49pm

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

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.

synesthesiam · March 14, 2020, 2:44am

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?

Jorg_Baumann · March 14, 2020, 1:26pm

@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

j3mu5 · March 16, 2020, 8:34am

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?

Bozor · March 18, 2020, 1:24am

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?

Jorg_Baumann · March 18, 2020, 4:15pm

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 ?

Bozor · March 18, 2020, 5:52pm

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

Still the same error.

Martin_Maier · March 18, 2020, 6:46pm

Since 2 days the latest docker image of 2.5.0-pre does not work for me on two different machines ( the first is an ubuntu server 18.04 and second a Pi3. After the install of the image the rhasspy-voltron container is permanently restarting and the command ‘docker logs container’ says:

find: relocation error: /usr/lib/rhasspy-voltron/.venv/tools/libpthread.so.0: symbol __libc_dl_error_tsd version GLIBC_PRIVATE not defined in file libc.so.6 with link time reference
python3: relocation error: /usr/lib/rhasspy-voltron/.venv/tools/libpthread.so.0: symbol __libc_dl_error_tsd version GLIBC_PRIVATE not defined in file libc.so.6 with link time reference<

Jorg_Baumann · March 18, 2020, 7:15pm

Hi,
the same behavior now with me ( and Bozor? ), container is always restarting.
An older Version of Voltron (2.5.0-pre) worked on my Pi4.
I think we have to wait for a new release ?

synesthesiam · March 18, 2020, 7:54pm

I made a mistake and had tested the wrong image before uploading. Will be fixing this today.

synesthesiam · March 18, 2020, 8:00pm

Yes, Rhasspy 2.5 brings its own broker inside the Docker image (mosquitto). This runs on port 12183 by default, so you can expose this port and bridge your brokers if you’d like.

If the flood came from audio messages, Rhasspy 2.5 has the option of sending audio via UDP before being woken up. This will keep the pre-wake audio off your broker, and only use MQTT to stream audio during an actual voice command.

Bozor · March 19, 2020, 9:31am

Thanks for fixing the image is working again.