Describe the bug
I ask Mycroft "what's the news" and Mycroft says "Here is this hour's news on ABC News Australia.", but nothing plays. I can see in the logs that the download is happening and it's attempting to play.
To Reproduce
Steps to reproduce the behavior:
Set location to Australia
Say "hey mycroft, what's the news"
Expected behavior
ABC news update should play
Log files
I asked Mycroft to read the news and sing to make sure the audio was working, I think this is the relevant bit from audio.log:
/var/log/mycroft/audio.log
```
2021-08-04 09:39:59.560 | INFO | 730 | audioservice_simple:stop:167 | SimpleAudioServiceStop
2021-08-04 09:39:59.564 | INFO | 730 | audioservice_simple:add_list:79 | Track list is [['file:///tmp/mycroft/cache/NewsSkill/stream', 'audio/mpeg']]
2021-08-04 09:39:59.565 | INFO | 730 | audioservice_simple:play:162 | Call SimpleAudioServicePlay
2021-08-04 09:39:59.592 | INFO | 730 | audioservice_simple:_play:97 | SimpleAudioService._play
High Performance MPEG 1.0/2.0/2.5 Audio Player for Layers 1, 2 and 3
version 1.25.10; written and copyright by Michael Hipp and others
free software (LGPL) without any warranty but with best wishes
Directory: /tmp/mycroft/cache/NewsSkill/
Playing MPEG stream 1 of 1: stream ...
Note: Illegal Audio-MPEG-Header 0x00000000 at offset 191.
Note: Trying to resync...
Note: Hit end of (available) data during resync.
[0:01] Decoding of stream finished.
2021-08-04 09:40:37.036 | INFO | 730 | mycroft.audio.speech:mute_and_speak:127 | Speak: Here is this hour's news on ABC News Australia.
Playing WAVE '/tmp/mycroft/cache/tts/Mimic/eab8e3fd5522993e6289713ad564829d.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Mono
2021-08-04 09:40:42.035 | INFO | 730 | audioservice_simple:stop:167 | SimpleAudioServiceStop
2021-08-04 09:40:42.046 | INFO | 730 | audioservice_simple:add_list:79 | Track list is [['file:///tmp/mycroft/cache/NewsSkill/stream', 'audio/mpeg']]
2021-08-04 09:40:42.049 | INFO | 730 | audioservice_simple:play:162 | Call SimpleAudioServicePlay
2021-08-04 09:40:42.064 | INFO | 730 | audioservice_simple:_play:97 | SimpleAudioService._play
High Performance MPEG 1.0/2.0/2.5 Audio Player for Layers 1, 2 and 3
version 1.25.10; written and copyright by Michael Hipp and others
free software (LGPL) without any warranty but with best wishes
Directory: /tmp/mycroft/cache/NewsSkill/
Playing MPEG stream 1 of 1: stream ...
Note: Illegal Audio-MPEG-Header 0x00000000 at offset 191.
Note: Trying to resync...
Note: Hit end of (available) data during resync.
[0:01] Decoding of stream finished.
2021-08-04 09:41:04.003 | INFO | 730 | mycroft.audio.speech:mute_and_speak:127 | Speak: I'm a bit nervous about my voice, but here goes nothing.
Playing WAVE '/tmp/mycroft/cache/tts/Mimic/5ad263cceb29e51b701eea5b135864f3.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Mono
2021-08-04 09:41:09.010 | INFO | 730 | audioservice_simple:stop:167 | SimpleAudioServiceStop
2021-08-04 09:41:09.015 | INFO | 730 | audioservice_simple:add_list:79 | Track list is ['file:///opt/mycroft/skills/mycroft-singing.mycroftai/popey-favourite.mp3']
2021-08-04 09:41:09.017 | INFO | 730 | audioservice_simple:play:162 | Call SimpleAudioServicePlay
2021-08-04 09:41:09.028 | INFO | 730 | audioservice_simple:_play:97 | SimpleAudioService._play
High Performance MPEG 1.0/2.0/2.5 Audio Player for Layers 1, 2 and 3
version 1.25.10; written and copyright by Michael Hipp and others
free software (LGPL) without any warranty but with best wishes
Directory: /opt/mycroft/skills/mycroft-singing.mycroftai/
Playing MPEG stream 1 of 1: popey-favourite.mp3 ...
MPEG 1.0 L III vbr 48000 j-s
2021-08-04 09:41:20.957 | INFO | 730 | audioservice_simple:stop:167 | SimpleAudioServiceStop
2021-08-04 09:41:22.162 | INFO | 730 | mycroft.audio.audioservice:_stop:350 | END Stop
2021-08-04 09:41:27.118 | ERROR | 730 | concurrent.futures | exception calling callback for
Traceback (most recent call last):
File "/usr/lib/python3.7/concurrent/futures/_base.py", line 324, in _invoke_callbacks
callback(self)
File "/home/pi/mycroft-core/.venv/lib/python3.7/site-packages/pyee/_executor.py", line 56, in _callback
self.emit('error', exc)
File "/home/pi/mycroft-core/.venv/lib/python3.7/site-packages/pyee/_base.py", line 116, in emit
self._emit_handle_potential_error(event, args[0] if args else None)
File "/home/pi/mycroft-core/.venv/lib/python3.7/site-packages/pyee/_base.py", line 86, in _emit_handle_potential_error
raise error
File "/usr/lib/python3.7/concurrent/futures/thread.py", line 57, in run
result = self.fn(*self.args, **self.kwargs)
File "/home/pi/mycroft-core/mycroft/audio/audioservice.py", line 391, in _restore_volume_after_record
restore_volume()
File "/home/pi/mycroft-core/mycroft/audio/audioservice.py", line 383, in restore_volume
self.current.restore_volume()
AttributeError: 'NoneType' object has no attribute 'restore_volume'
2021-08-04 09:41:53.871 | INFO | 730 | mycroft.audio.speech:mute_and_speak:127 | Speak: Here is this hour's news on ABC News Australia.
2021-08-04 09:41:53.873 | INFO | 730 | mycroft.tts.tts:_get_sentence_from_cache:392 | Found eab8e3fd5522993e6289713ad564829d.wav in TTS cache
Playing WAVE '/tmp/mycroft/cache/tts/Mimic/eab8e3fd5522993e6289713ad564829d.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Mono
2021-08-04 09:41:57.735 | INFO | 730 | audioservice_simple:add_list:79 | Track list is [['file:///tmp/mycroft/cache/NewsSkill/stream', 'audio/mpeg']]
2021-08-04 09:41:57.743 | INFO | 730 | audioservice_simple:play:162 | Call SimpleAudioServicePlay
2021-08-04 09:41:57.761 | INFO | 730 | audioservice_simple:_play:97 | SimpleAudioService._play
High Performance MPEG 1.0/2.0/2.5 Audio Player for Layers 1, 2 and 3
version 1.25.10; written and copyright by Michael Hipp and others
free software (LGPL) without any warranty but with best wishes
Directory: /tmp/mycroft/cache/NewsSkill/
Playing MPEG stream 1 of 1: stream ...
Note: Illegal Audio-MPEG-Header 0x00000000 at offset 191.
Note: Trying to resync...
Note: Hit end of (available) data during resync.
[0:01] Decoding of stream finished.
```
Environment (please complete the following information):
Device type: Raspberry Pi
OS: Picroft
Mycroft-core version: 21.2.0
Other versions: N/A
I'm using a Jabra 510 and had to modify the play commands during setup based on the troubleshooting guide.
Describe the bug I ask Mycroft "what's the news" and Mycroft says "Here is this hour's news on ABC News Australia.", but nothing plays. I can see in the logs that the download is happening and it's attempting to play.
To Reproduce Steps to reproduce the behavior:
Expected behavior ABC news update should play
Log files
I asked Mycroft to read the news and sing to make sure the audio was working, I think this is the relevant bit from audio.log:
/var/log/mycroft/audio.log
``` 2021-08-04 09:39:59.560 | INFO | 730 | audioservice_simple:stop:167 | SimpleAudioServiceStop 2021-08-04 09:39:59.564 | INFO | 730 | audioservice_simple:add_list:79 | Track list is [['file:///tmp/mycroft/cache/NewsSkill/stream', 'audio/mpeg']] 2021-08-04 09:39:59.565 | INFO | 730 | audioservice_simple:play:162 | Call SimpleAudioServicePlay 2021-08-04 09:39:59.592 | INFO | 730 | audioservice_simple:_play:97 | SimpleAudioService._play High Performance MPEG 1.0/2.0/2.5 Audio Player for Layers 1, 2 and 3 version 1.25.10; written and copyright by Michael Hipp and others free software (LGPL) without any warranty but with best wishes Directory: /tmp/mycroft/cache/NewsSkill/ Playing MPEG stream 1 of 1: stream ... Note: Illegal Audio-MPEG-Header 0x00000000 at offset 191. Note: Trying to resync... Note: Hit end of (available) data during resync. [0:01] Decoding of stream finished. 2021-08-04 09:40:37.036 | INFO | 730 | mycroft.audio.speech:mute_and_speak:127 | Speak: Here is this hour's news on ABC News Australia. Playing WAVE '/tmp/mycroft/cache/tts/Mimic/eab8e3fd5522993e6289713ad564829d.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Mono 2021-08-04 09:40:42.035 | INFO | 730 | audioservice_simple:stop:167 | SimpleAudioServiceStop 2021-08-04 09:40:42.046 | INFO | 730 | audioservice_simple:add_list:79 | Track list is [['file:///tmp/mycroft/cache/NewsSkill/stream', 'audio/mpeg']] 2021-08-04 09:40:42.049 | INFO | 730 | audioservice_simple:play:162 | Call SimpleAudioServicePlay 2021-08-04 09:40:42.064 | INFO | 730 | audioservice_simple:_play:97 | SimpleAudioService._play High Performance MPEG 1.0/2.0/2.5 Audio Player for Layers 1, 2 and 3 version 1.25.10; written and copyright by Michael Hipp and others free software (LGPL) without any warranty but with best wishes Directory: /tmp/mycroft/cache/NewsSkill/ Playing MPEG stream 1 of 1: stream ... Note: Illegal Audio-MPEG-Header 0x00000000 at offset 191. Note: Trying to resync... Note: Hit end of (available) data during resync. [0:01] Decoding of stream finished. 2021-08-04 09:41:04.003 | INFO | 730 | mycroft.audio.speech:mute_and_speak:127 | Speak: I'm a bit nervous about my voice, but here goes nothing. Playing WAVE '/tmp/mycroft/cache/tts/Mimic/5ad263cceb29e51b701eea5b135864f3.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Mono 2021-08-04 09:41:09.010 | INFO | 730 | audioservice_simple:stop:167 | SimpleAudioServiceStop 2021-08-04 09:41:09.015 | INFO | 730 | audioservice_simple:add_list:79 | Track list is ['file:///opt/mycroft/skills/mycroft-singing.mycroftai/popey-favourite.mp3'] 2021-08-04 09:41:09.017 | INFO | 730 | audioservice_simple:play:162 | Call SimpleAudioServicePlay 2021-08-04 09:41:09.028 | INFO | 730 | audioservice_simple:_play:97 | SimpleAudioService._play High Performance MPEG 1.0/2.0/2.5 Audio Player for Layers 1, 2 and 3 version 1.25.10; written and copyright by Michael Hipp and others free software (LGPL) without any warranty but with best wishes Directory: /opt/mycroft/skills/mycroft-singing.mycroftai/ Playing MPEG stream 1 of 1: popey-favourite.mp3 ... MPEG 1.0 L III vbr 48000 j-s 2021-08-04 09:41:20.957 | INFO | 730 | audioservice_simple:stop:167 | SimpleAudioServiceStop 2021-08-04 09:41:22.162 | INFO | 730 | mycroft.audio.audioservice:_stop:350 | END Stop 2021-08-04 09:41:27.118 | ERROR | 730 | concurrent.futures | exception calling callback forEnvironment (please complete the following information):
I'm using a Jabra 510 and had to modify the play commands during setup based on the troubleshooting guide.