andrenatal / voice-addon

Handsfree Voice addon for Mozilla's WoT Gateway
Mozilla Public License 2.0
9 stars 10 forks source link

Error after update #18

Closed flatsiedatsie closed 5 years ago

flatsiedatsie commented 5 years ago

I suspect something went wrong with the update?

Feb 18 10:17:23 gateway snips-analytics[2926]: ERROR:snips_analytics               : Could not start MQTT client on localhost:1883
Feb 18 10:17:23 gateway snips-analytics[2926]:  -> caused by: Connection refused (os error 111)
Feb 18 10:17:23 gateway systemd[1]: Stopped Snips Analytics.
Feb 18 10:17:23 gateway snips-nlu[2924]: INFO:snips_heartbeat::cliconfig_ext: Heartbeat disabled
Feb 18 10:17:23 gateway snips-nlu[2924]: ERROR:snips_nlu                     : Could not start MQTT client on localhost:1883
Feb 18 10:17:23 gateway snips-nlu[2924]:  -> caused by: Connection refused (os error 111)
Feb 18 10:17:23 gateway systemd[1]: Started Snips Analytics.
Feb 18 10:17:23 gateway systemd[1]: snips-hotword.service: Main process exited, code=exited, status=1/FAILURE
Feb 18 10:17:23 gateway systemd[1]: snips-hotword.service: Unit entered failed state.
Feb 18 10:17:23 gateway systemd[1]: snips-hotword.service: Failed with result 'exit-code'.
Feb 18 10:17:23 gateway systemd[1]: snips-dialogue.service: Main process exited, code=exited, status=1/FAILURE
Feb 18 10:17:23 gateway systemd[1]: snips-dialogue.service: Unit entered failed state.
Feb 18 10:17:23 gateway systemd[1]: snips-dialogue.service: Failed with result 'exit-code'.
Feb 18 10:17:23 gateway systemd[1]: snips-nlu.service: Main process exited, code=exited, status=1/FAILURE
Feb 18 10:17:23 gateway systemd[1]: snips-nlu.service: Unit entered failed state.
Feb 18 10:17:23 gateway systemd[1]: snips-nlu.service: Failed with result 'exit-code'.
Feb 18 10:17:23 gateway systemd[1]: snips-tts.service: Main process exited, code=exited, status=1/FAILURE
Feb 18 10:17:23 gateway systemd[1]: snips-tts.service: Unit entered failed state.
Feb 18 10:17:23 gateway systemd[1]: snips-tts.service: Failed with result 'exit-code'.
Feb 18 10:17:23 gateway systemd[1]: snips-analytics.service: Main process exited, code=exited, status=1/FAILURE
Feb 18 10:17:23 gateway systemd[1]: snips-analytics.service: Unit entered failed state.
Feb 18 10:17:23 gateway systemd[1]: snips-analytics.service: Failed with result 'exit-code'.
Feb 18 10:17:24 gateway systemd[1]: snips-audio-server.service: Service hold-off time over, scheduling restart.
Feb 18 10:17:24 gateway systemd[1]: snips-asr.service: Service hold-off time over, scheduling restart.
Feb 18 10:17:24 gateway systemd[1]: snips-injection.service: Service hold-off time over, scheduling restart.
Feb 18 10:17:24 gateway systemd[1]: Stopped Snips Injection.
Feb 18 10:17:24 gateway systemd[1]: Started Snips Injection.
Feb 18 10:17:24 gateway systemd[1]: Stopped Snips ASR.
Feb 18 10:17:24 gateway systemd[1]: Started Snips ASR.
Feb 18 10:17:24 gateway systemd[1]: Stopped Snips Audio Server.
Feb 18 10:17:24 gateway systemd[1]: Started Snips Audio Server.
Feb 18 10:17:24 gateway snips-audio-server[2934]: INFO:snips_heartbeat::cliconfig_ext: Heartbeat disabled
Feb 18 10:17:24 gateway snips-audio-server[2934]: ERROR:snips_audio_server            : Could not start MQTT client on localhost:1883
Feb 18 10:17:24 gateway snips-audio-server[2934]:  -> caused by: Connection refused (os error 111)
Feb 18 10:17:24 gateway systemd[1]: snips-audio-server.service: Main process exited, code=exited, status=1/FAILURE
Feb 18 10:17:24 gateway systemd[1]: snips-audio-server.service: Unit entered failed state.
Feb 18 10:17:24 gateway systemd[1]: snips-audio-server.service: Failed with result 'exit-code'.
Feb 18 10:17:24 gateway snips-injection[2932]: ERROR:snips_injection: Could not start MQTT client on localhost:1883
Feb 18 10:17:24 gateway snips-injection[2932]:  -> caused by: Connection refused (os error 111)
Feb 18 10:17:24 gateway systemd[1]: snips-injection.service: Main process exited, code=exited, status=1/FAILURE
Feb 18 10:17:24 gateway systemd[1]: snips-injection.service: Unit entered failed state.
Feb 18 10:17:24 gateway systemd[1]: snips-injection.service: Failed with result 'exit-code'.
Feb 18 10:17:24 gateway snips-asr[2933]: INFO:snips_heartbeat::cliconfig_ext: Heartbeat disabled
Feb 18 10:17:24 gateway snips-asr[2933]: ERROR:snips_asr                     : Could not start MQTT client on localhost:1883
Feb 18 10:17:24 gateway snips-asr[2933]:  -> caused by: Connection refused (os error 111)
Feb 18 10:17:24 gateway systemd[1]: snips-asr.service: Main process exited, code=exited, status=1/FAILURE
Feb 18 10:17:24 gateway systemd[1]: snips-asr.service: Unit entered failed state.
Feb 18 10:17:24 gateway systemd[1]: snips-asr.service: Failed with result 'exit-code'.
Feb 18 10:17:28 gateway systemd[1]: snips-hotword.service: Service hold-off time over, scheduling restart.
Feb 18 10:17:28 gateway systemd[1]: snips-analytics.service: Service hold-off time over, scheduling restart.
Feb 18 10:17:28 gateway systemd[1]: snips-dialogue.service: Service hold-off time over, scheduling restart.
Feb 18 10:17:28 gateway systemd[1]: snips-nlu.service: Service hold-off time over, scheduling restart.
Feb 18 10:17:28 gateway systemd[1]: snips-tts.service: Service hold-off time over, scheduling restart.
Feb 18 10:17:28 gateway systemd[1]: Stopped Snips TTS.
Feb 18 10:17:28 gateway systemd[1]: Started Snips TTS.
Feb 18 10:17:28 gateway systemd[1]: Stopped Snips NLU.
Feb 18 10:17:28 gateway systemd[1]: Started Snips NLU.
Feb 18 10:17:28 gateway systemd[1]: Stopped Snips Dialogue.
Feb 18 10:17:28 gateway systemd[1]: Started Snips Dialogue.
Feb 18 10:17:28 gateway snips-tts[2938]: INFO:snips_heartbeat::cliconfig_ext: Heartbeat disabled
Feb 18 10:17:28 gateway snips-tts[2938]: ERROR:snips_tts                     : Could not start MQTT client on localhost:1883
Feb 18 10:17:28 gateway snips-tts[2938]:  -> caused by: Connection refused (os error 111)
Feb 18 10:17:28 gateway systemd[1]: Stopped Snips Analytics.
Feb 18 10:17:28 gateway systemd[1]: Started Snips Analytics.
Feb 18 10:17:28 gateway snips-dialogue[2940]: INFO:snips_heartbeat::cliconfig_ext: Heartbeat disabled
Feb 18 10:17:28 gateway systemd[1]: Stopped Snips Hotword.
Feb 18 10:17:28 gateway systemd[1]: Started Snips Hotword.
Feb 18 10:17:28 gateway snips-analytics[2941]: INFO:snips_heartbeat::cliconfig_ext: Heartbeat disabled
Feb 18 10:17:28 gateway snips-nlu[2939]: INFO:snips_heartbeat::cliconfig_ext: Heartbeat disabled
Feb 18 10:17:28 gateway snips-dialogue[2940]: ERROR:snips_dialogue                : Could not start MQTT client on localhost:1883
Feb 18 10:17:28 gateway snips-dialogue[2940]:  -> caused by: Connection refused (os error 111)
Feb 18 10:17:28 gateway snips-analytics[2941]: ERROR:snips_analytics               : Could not start MQTT client on localhost:1883
Feb 18 10:17:28 gateway snips-analytics[2941]:  -> caused by: Connection refused (os error 111)
Feb 18 10:17:28 gateway snips-nlu[2939]: ERROR:snips_nlu                     : Could not start MQTT client on localhost:1883
Feb 18 10:17:28 gateway snips-nlu[2939]:  -> caused by: Connection refused (os error 111)
Feb 18 10:17:28 gateway snips-hotword[2943]: INFO:snips_heartbeat::cliconfig_ext: Heartbeat disabled
Feb 18 10:17:28 gateway snips-hotword[2943]: ERROR:snips_hotword                 : Could not start MQTT client on localhost:1883
Feb 18 10:17:28 gateway snips-hotword[2943]:  -> caused by: Connection refused (os error 111)
Feb 18 10:17:28 gateway systemd[1]: snips-tts.service: Main process exited, code=exited, status=1/FAILURE
Feb 18 10:17:28 gateway systemd[1]: snips-tts.service: Unit entered failed state.
Feb 18 10:17:28 gateway systemd[1]: snips-tts.service: Failed with result 'exit-code'.
Feb 18 10:17:28 gateway systemd[1]: snips-nlu.service: Main process exited, code=exited, status=1/FAILURE
Feb 18 10:17:28 gateway systemd[1]: snips-nlu.service: Unit entered failed state.
Feb 18 10:17:28 gateway systemd[1]: snips-nlu.service: Failed with result 'exit-code'.
Feb 18 10:17:28 gateway systemd[1]: snips-dialogue.service: Main process exited, code=exited, status=1/FAILURE
Feb 18 10:17:28 gateway systemd[1]: snips-dialogue.service: Unit entered failed state.
Feb 18 10:17:28 gateway systemd[1]: snips-dialogue.service: Failed with result 'exit-code'.
Feb 18 10:17:28 gateway systemd[1]: snips-analytics.service: Main process exited, code=exited, status=1/FAILURE
Feb 18 10:17:28 gateway systemd[1]: snips-analytics.service: Unit entered failed state.
Feb 18 10:17:28 gateway systemd[1]: snips-analytics.service: Failed with result 'exit-code'.
Feb 18 10:17:28 gateway systemd[1]: snips-hotword.service: Main process exited, code=exited, status=1/FAILURE
Feb 18 10:17:28 gateway systemd[1]: snips-hotword.service: Unit entered failed state.
Feb 18 10:17:28 gateway systemd[1]: snips-hotword.service: Failed with result 'exit-code'.
Feb 18 10:17:29 gateway systemd[1]: snips-audio-server.service: Service hold-off time over, scheduling restart.
Feb 18 10:17:29 gateway systemd[1]: snips-asr.service: Service hold-off time over, scheduling restart.
Feb 18 10:17:29 gateway systemd[1]: snips-injection.service: Service hold-off time over, scheduling restart.
Feb 18 10:17:29 gateway systemd[1]: Stopped Snips Injection.
Feb 18 10:17:29 gateway systemd[1]: Started Snips Injection.
Feb 18 10:17:29 gateway systemd[1]: Stopped Snips ASR.
Feb 18 10:17:29 gateway systemd[1]: Started Snips ASR.
Feb 18 10:17:29 gateway systemd[1]: Stopped Snips Audio Server.
Feb 18 10:17:29 gateway systemd[1]: Started Snips Audio Server.
Feb 18 10:17:29 gateway snips-injection[2948]: ERROR:snips_injection: Could not start MQTT client on localhost:1883
Feb 18 10:17:29 gateway snips-injection[2948]:  -> caused by: Connection refused (os error 111)
Feb 18 10:17:29 gateway snips-audio-server[2950]: INFO:snips_heartbeat::cliconfig_ext: Heartbeat disabled
Feb 18 10:17:29 gateway systemd[1]: snips-injection.service: Main process exited, code=exited, status=1/FAILURE
Feb 18 10:17:29 gateway systemd[1]: snips-injection.service: Unit entered failed state.
Feb 18 10:17:29 gateway systemd[1]: snips-injection.service: Failed with result 'exit-code'.
Feb 18 10:17:29 gateway snips-audio-server[2950]: ERROR:snips_audio_server            : Could not start MQTT client on localhost:1883
Feb 18 10:17:29 gateway snips-audio-server[2950]:  -> caused by: Connection refused (os error 111)
Feb 18 10:17:29 gateway systemd[1]: snips-audio-server.service: Main process exited, code=exited, status=1/FAILURE
Feb 18 10:17:29 gateway systemd[1]: snips-audio-server.service: Unit entered failed state.
Feb 18 10:17:29 gateway systemd[1]: snips-audio-server.service: Failed with result 'exit-code'.
Feb 18 10:17:29 gateway snips-asr[2949]: INFO:snips_heartbeat::cliconfig_ext: Heartbeat disabled
Feb 18 10:17:29 gateway snips-asr[2949]: ERROR:snips_asr                     : Could not start MQTT client on localhost:1883
Feb 18 10:17:29 gateway snips-asr[2949]:  -> caused by: Connection refused (os error 111)
Feb 18 10:17:29 gateway systemd[1]: snips-asr.service: Main process exited, code=exited, status=1/FAILURE
Feb 18 10:17:29 gateway systemd[1]: snips-asr.service: Unit entered failed state.
Feb 18 10:17:29 gateway systemd[1]: snips-asr.service: Failed with result 'exit-code'.
Feb 18 10:17:32 gateway run-app.sh[503]: 2019-02-18 10:17:32.061 ERROR  : voice-addon: problem with request: connect ECONNREFUSED 127.0.0.1:4443
Feb 18 10:17:33 gateway systemd[1]: snips-tts.service: Service hold-off time over, scheduling restart.
Feb 18 10:17:33 gateway systemd[1]: snips-hotword.service: Service hold-off time over, scheduling restart.
Feb 18 10:17:33 gateway systemd[1]: snips-nlu.service: Service hold-off time over, scheduling restart.
Feb 18 10:17:33 gateway systemd[1]: snips-dialogue.service: Service hold-off time over, scheduling restart.
Feb 18 10:17:33 gateway systemd[1]: snips-analytics.service: Service hold-off time over, scheduling restart.
Feb 18 10:17:33 gateway systemd[1]: Stopped Snips Analytics.
Feb 18 10:17:33 gateway systemd[1]: Started Snips Analytics.
Feb 18 10:17:33 gateway systemd[1]: Stopped Snips Dialogue.
Feb 18 10:17:33 gateway systemd[1]: Started Snips Dialogue.
Feb 18 10:17:33 gateway systemd[1]: Stopped Snips NLU.
Feb 18 10:17:33 gateway systemd[1]: Started Snips NLU.
Feb 18 10:17:33 gateway snips-analytics[2954]: INFO:snips_heartbeat::cliconfig_ext: Heartbeat disabled
Feb 18 10:17:33 gateway snips-analytics[2954]: ERROR:snips_analytics               : Could not start MQTT client on localhost:1883
Feb 18 10:17:33 gateway snips-analytics[2954]:  -> caused by: Connection refused (os error 111)
Feb 18 10:17:33 gateway systemd[1]: Stopped Snips Hotword.
Feb 18 10:17:33 gateway snips-dialogue[2955]: INFO:snips_heartbeat::cliconfig_ext: Heartbeat disabled
Feb 18 10:17:33 gateway snips-dialogue[2955]: ERROR:snips_dialogue                : Could not start MQTT client on localhost:1883
Feb 18 10:17:33 gateway snips-dialogue[2955]:  -> caused by: Connection refused (os error 111)
Feb 18 10:17:33 gateway systemd[1]: Started Snips Hotword.
Feb 18 10:17:33 gateway snips-nlu[2956]: INFO:snips_heartbeat::cliconfig_ext: Heartbeat disabled
Feb 18 10:17:33 gateway snips-nlu[2956]: ERROR:snips_nlu                     : Could not start MQTT client on localhost:1883
Feb 18 10:17:33 gateway snips-nlu[2956]:  -> caused by: Connection refused (os error 111)
Feb 18 10:17:33 gateway systemd[1]: Stopped Snips TTS.
Feb 18 10:17:33 gateway snips-hotword[2957]: INFO:snips_heartbeat::cliconfig_ext: Heartbeat disabled
Feb 18 10:17:33 gateway snips-hotword[2957]: ERROR:snips_hotword                 : Could not start MQTT client on localhost:1883
Feb 18 10:17:33 gateway snips-hotword[2957]:  -> caused by: Connection refused (os error 111)
Feb 18 10:17:33 gateway systemd[1]: Started Snips TTS.
Feb 18 10:17:33 gateway snips-tts[2960]: INFO:snips_heartbeat::cliconfig_ext: Heartbeat disabled
Feb 18 10:17:33 gateway snips-tts[2960]: ERROR:snips_tts                     : Could not start MQTT client on localhost:1883
Feb 18 10:17:33 gateway snips-tts[2960]:  -> caused by: Connection refused (os error 111)
Feb 18 10:17:33 gateway systemd[1]: snips-analytics.service: Main process exited, code=exited, status=1/FAILURE
Feb 18 10:17:33 gateway systemd[1]: snips-analytics.service: Unit entered failed state.
Feb 18 10:17:33 gateway systemd[1]: snips-analytics.service: Failed with result 'exit-code'.
Feb 18 10:17:33 gateway systemd[1]: snips-dialogue.service: Main process exited, code=exited, status=1/FAILURE
Feb 18 10:17:33 gateway systemd[1]: snips-dialogue.service: Unit entered failed state.
Feb 18 10:17:33 gateway systemd[1]: snips-dialogue.service: Failed with result 'exit-code'.
Feb 18 10:17:33 gateway systemd[1]: snips-nlu.service: Main process exited, code=exited, status=1/FAILURE
Feb 18 10:17:33 gateway systemd[1]: snips-nlu.service: Unit entered failed state.
Feb 18 10:17:33 gateway systemd[1]: snips-nlu.service: Failed with result 'exit-code'.
Feb 18 10:17:33 gateway systemd[1]: snips-hotword.service: Main process exited, code=exited, status=1/FAILURE
flatsiedatsie commented 5 years ago

I installed moquitto, and now I get just this error:

Feb 18 10:28:12 gateway run-app.sh[503]: 2019-02-18 10:28:12.270 ERROR  : voice-addon: problem with request: connect ECONNREFUSED 127.0.0.1:4443
Feb 18 10:28:22 gateway run-app.sh[503]: 2019-02-18 10:28:22.275 ERROR  : voice-addon: problem with request: connect ECONNREFUSED 127.0.0.1:4443
Feb 18 10:28:32 gateway run-app.sh[503]: 2019-02-18 10:28:32.279 ERROR  : voice-addon: problem with request: connect ECONNREFUSED 127.0.0.1:4443
Feb 18 10:28:42 gateway run-app.sh[503]: 2019-02-18 10:28:42.284 ERROR  : voice-addon: problem with request: connect ECONNREFUSED 127.0.0.1:4443
flatsiedatsie commented 5 years ago

Netstat shows this:

pi@gateway:/etc/apt/sources.list.d $ netstat -lptn
(Not all processes could be identified, non-owned process info
 will not be shown, you would have to be root to see it all.)
Active Internet connections (only servers)
Proto Recv-Q Send-Q Local Address           Foreign Address         State       PID/Program name    
tcp        0      0 0.0.0.0:5003            0.0.0.0:*               LISTEN      -                   
tcp        0      0 127.0.0.1:5555          0.0.0.0:*               LISTEN      -                   
tcp        0      0 0.0.0.0:22              0.0.0.0:*               LISTEN      -                   
tcp        0      0 0.0.0.0:8023            0.0.0.0:*               LISTEN      -                   
tcp        0      0 0.0.0.0:8888            0.0.0.0:*               LISTEN      -                   
tcp        0      0 0.0.0.0:8024            0.0.0.0:*               LISTEN      -                   
tcp        0      0 0.0.0.0:1883            0.0.0.0:*               LISTEN      6003/mosquitto      
tcp        0      0 0.0.0.0:8000            0.0.0.0:*               LISTEN      -                   
tcp6       0      0 :::4747                 :::*                    LISTEN      -                   
tcp6       0      0 :::8080                 :::*                    LISTEN      -                   
tcp6       0      0 :::8787                 :::*                    LISTEN      -                   
tcp6       0      0 :::22                   :::*                    LISTEN      -                   
tcp6       0      0 :::1883                 :::*                    LISTEN      6003/mosquitto      
tcp6       0      0 :::6144                 :::*                    LISTEN      - 
flatsiedatsie commented 5 years ago

I just created a fresh SD card with just the 0.7 image of the Mozilla Gateway. I then installed the add-on.

Already during installation of the plugin I see familiar errors:

Feb 18 12:45:13 gateway run-app.sh[509]: 2019-02-18 12:45:13.152 INFO   : voice-addon: DATA snips_installation: Selecting previously unselected package snips-injection.
Feb 18 12:45:13 gateway run-app.sh[509]: 2019-02-18 12:45:13.155 INFO   : voice-addon: DATA snips_installation: 
Feb 18 12:45:13 gateway run-app.sh[509]: 2019-02-18 12:45:13.157 INFO   : voice-addon: 
Feb 18 12:45:13 gateway run-app.sh[509]: 2019-02-18 12:45:13.171 INFO   : voice-addon: DATA snips_installation: Preparing to unpack .../5-snips-injection_0.60.12_armhf.deb ...
Feb 18 12:45:13 gateway run-app.sh[509]: 2019-02-18 12:45:13.173 INFO   : voice-addon: DATA snips_installation: 
Feb 18 12:45:13 gateway run-app.sh[509]: 2019-02-18 12:45:13.174 INFO   : voice-addon: 
Feb 18 12:45:13 gateway run-app.sh[509]: 2019-02-18 12:45:13.212 INFO   : voice-addon: DATA snips_installation: Unpacking snips-injection (0.60.12) ...
Feb 18 12:45:13 gateway run-app.sh[509]: 2019-02-18 12:45:13.214 INFO   : voice-addon: DATA snips_installation: 
Feb 18 12:45:13 gateway run-app.sh[509]: 2019-02-18 12:45:13.216 INFO   : voice-addon: 
Feb 18 12:45:13 gateway run-app.sh[509]: 2019-02-18 12:45:13.595 ERROR  : voice-addon: problem with request: connect ECONNREFUSED 127.0.0.1:4443

Ending in:

Feb 18 12:47:02 gateway run-app.sh[509]: 2019-02-18 12:47:02.409 INFO   : voice-addon: DATA snips_installation: (Reading database ... 65%
Feb 18 12:47:02 gateway run-app.sh[509]: 2019-02-18 12:47:02.411 INFO   : voice-addon: DATA snips_installation: (Reading database ... 70%
Feb 18 12:47:02 gateway run-app.sh[509]: 2019-02-18 12:47:02.413 INFO   : voice-addon: DATA snips_installation: (Reading database ... 75%
Feb 18 12:47:02 gateway run-app.sh[509]: 2019-02-18 12:47:02.415 INFO   : voice-addon: DATA snips_installation: (Reading database ... 80%
Feb 18 12:47:02 gateway run-app.sh[509]: 2019-02-18 12:47:02.419 INFO   : voice-addon: DATA snips_installation: (Reading database ... 85%
Feb 18 12:47:02 gateway run-app.sh[509]: 2019-02-18 12:47:02.434 INFO   : voice-addon: DATA snips_installation: (Reading database ... 90%
Feb 18 12:47:02 gateway run-app.sh[509]: 2019-02-18 12:47:02.454 INFO   : voice-addon: DATA snips_installation: (Reading database ... 95%
Feb 18 12:47:02 gateway run-app.sh[509]: 2019-02-18 12:47:02.459 INFO   : voice-addon: DATA snips_installation: (Reading database ... 100%
Feb 18 12:47:02 gateway run-app.sh[509]: 2019-02-18 12:47:02.461 INFO   : voice-addon: (Reading database ... 54716 files and directories currently installed.)
Feb 18 12:47:02 gateway run-app.sh[509]: 2019-02-18 12:47:02.462 INFO   : voice-addon: 
Feb 18 12:47:02 gateway run-app.sh[509]: 2019-02-18 12:47:02.475 INFO   : voice-addon: DATA snips_installation: Preparing to unpack .../python-ply_3.9-1_all.deb ...
Feb 18 12:47:02 gateway run-app.sh[509]: 2019-02-18 12:47:02.476 INFO   : voice-addon: 
Feb 18 12:47:02 gateway run-app.sh[509]: 2019-02-18 12:47:02.519 INFO   : voice-addon: DATA snips_installation: Unpacking python-ply (3.9-1) ...
Feb 18 12:47:02 gateway run-app.sh[509]: 2019-02-18 12:47:02.521 INFO   : voice-addon: 
Feb 18 12:47:02 gateway systemd[1]: snips-nlu.service: Service hold-off time over, scheduling restart.
Feb 18 12:47:02 gateway systemd[1]: Stopped Snips NLU.
Feb 18 12:47:02 gateway systemd[1]: Started Snips NLU.
Feb 18 12:47:02 gateway snips-nlu[3432]: INFO:snips_nlu_hermes: loading nlu engine "/usr/share/snips/assistant/nlu_engine"
Feb 18 12:47:02 gateway snips-nlu[3432]: ERROR:snips_nlu_hermes: nlu thread ended with error: Unable to read file '/usr/share/snips/assistant/nlu_engine/nlu_engine.json'
Feb 18 12:47:02 gateway snips-nlu[3432]:  -> caused by: Permission denied (os error 13)
Feb 18 12:47:02 gateway snips-nlu[3432]: ERROR:rumqtt::client  : snips-nlu|3432-gateway-1 Disconnected: (Error(SyncMpsc(Disconnected), State { next_error: None, backtrace: None }))
Feb 18 12:47:02 gateway snips-nlu[3432]: ERROR:snips_nlu       : Fail to wait end of pipeline
Feb 18 12:47:02 gateway snips-nlu[3432]:  -> caused by: Unable to read file '/usr/share/snips/assistant/nlu_engine/nlu_engine.json'
Feb 18 12:47:02 gateway snips-nlu[3432]:  -> caused by: Permission denied (os error 13)
Feb 18 12:47:02 gateway systemd[1]: snips-nlu.service: Main process exited, code=exited, status=1/FAILURE
Feb 18 12:47:02 gateway systemd[1]: snips-nlu.service: Unit entered failed state.
Feb 18 12:47:02 gateway systemd[1]: snips-nlu.service: Failed with result 'exit-code'.
Feb 18 12:47:02 gateway run-app.sh[509]: 2019-02-18 12:47:02.824 INFO   : voice-addon: DATA snips_installation: Selecting previously unselected package python-pycparser.
Feb 18 12:47:02 gateway run-app.sh[509]: 2019-02-18 12:47:02.825 INFO   : voice-addon: 
Feb 18 12:47:02 gateway run-app.sh[509]: 2019-02-18 12:47:02.843 INFO   : voice-addon: DATA snips_installation: Preparing to unpack .../python-pycparser_2.17-2_all.deb ...
Feb 18 12:47:02 gateway run-app.sh[509]: 2019-02-18 12:47:02.844 INFO   : voice-addon: 
Feb 18 12:47:02 gateway run-app.sh[509]: 2019-02-18 12:47:02.854 INFO   : voice-addon: DATA snips_installation: Unpacking python-pycparser (2.17-2) ...
Feb 18 12:47:02 gateway run-app.sh[509]: 2019-02-18 12:47:02.856 INFO   : voice-addon: 
Feb 18 12:47:03 gateway run-app.sh[509]: 2019-02-18 12:47:03.625 ERROR  : voice-addon: problem with request: connect ECONNREFUSED 127.0.0.1:4443
Feb 18 12:47:04 gateway run-app.sh[509]: 2019-02-18 12:47:04.575 INFO   : voice-addon: DATA snips_installation: Selecting previously unselected package python-cffi.
Feb 18 12:47:04 gateway run-app.sh[509]: 2019-02-18 12:47:04.577 INFO   : voice-addon: 
Feb 18 12:47:04 gateway run-app.sh[509]: 2019-02-18 12:47:04.594 INFO   : voice-addon: DATA snips_installation: Preparing to unpack .../python-cffi_1.9.1-2_all.deb ...
Feb 18 12:47:04 gateway run-app.sh[509]: 2019-02-18 12:47:04.596 INFO   : voice-addon: 
Feb 18 12:47:04 gateway run-app.sh[509]: 2019-02-18 12:47:04.636 INFO   : voice-addon: DATA snips_installation: Unpacking python-cffi (1.9.1-2) ...
Feb 18 12:47:04 gateway run-app.sh[509]: 2019-02-18 12:47:04.638 INFO   : voice-addon: 
Feb 18 12:47:04 gateway run-app.sh[509]: 2019-02-18 12:47:04.986 INFO   : voice-addon: DATA snips_installation: Selecting previously unselected package python-soundfile.
Feb 18 12:47:04 gateway run-app.sh[509]: 2019-02-18 12:47:04.988 INFO   : voice-addon: 
Feb 18 12:47:05 gateway run-app.sh[509]: 2019-02-18 12:47:05.006 INFO   : voice-addon: DATA snips_installation: Preparing to unpack .../python-soundfile_0.8.1-2_all.deb ...
Feb 18 12:47:05 gateway run-app.sh[509]: 2019-02-18 12:47:05.008 INFO   : voice-addon: 
Feb 18 12:47:05 gateway run-app.sh[509]: 2019-02-18 12:47:05.046 INFO   : voice-addon: DATA snips_installation: Unpacking python-soundfile (0.8.1-2) ...
Feb 18 12:47:05 gateway run-app.sh[509]: 2019-02-18 12:47:05.048 INFO   : voice-addon: 
Feb 18 12:47:05 gateway systemd[1]: snips-asr.service: Service hold-off time over, scheduling restart.
Feb 18 12:47:05 gateway systemd[1]: Stopped Snips ASR.
Feb 18 12:47:05 gateway systemd[1]: Started Snips ASR.
Feb 18 12:47:05 gateway run-app.sh[509]: 2019-02-18 12:47:05.453 INFO   : voice-addon: DATA snips_installation: Setting up python-ply (3.9-1) ...
Feb 18 12:47:05 gateway run-app.sh[509]: 2019-02-18 12:47:05.454 INFO   : voice-addon: 
Feb 18 12:47:05 gateway snips-asr[3466]: INFO:snips_asr: Connecting using MQTT site-id default
Feb 18 12:47:05 gateway snips-asr[3466]: INFO:snips_asr_hermes: Using model from "/usr/share/snips/assistant/custom_asr"
Feb 18 12:47:05 gateway snips-asr[3466]: ERROR:snips_asr_hermes: Asr main thread ended with error: A problem occurred with resources
Feb 18 12:47:05 gateway snips-asr[3466]:  -> caused by: An I/O error occurred
Feb 18 12:47:05 gateway snips-asr[3466]:  -> caused by: Permission denied (os error 13)
Feb 18 12:47:05 gateway snips-asr[3466]: ERROR:rumqtt::client  : snips-asr|3466-gateway-3 Disconnected: (Error(SyncMpsc(Disconnected), State { next_error: None, backtrace: None }))
Feb 18 12:47:05 gateway snips-asr[3466]: INFO:snips_asr       : Pipeline is finished
Feb 18 12:47:05 gateway snips-asr[3466]: ERROR:snips_asr       : A problem occurred with resources
Feb 18 12:47:05 gateway snips-asr[3466]:  -> caused by: An I/O error occurred
Feb 18 12:47:05 gateway snips-asr[3466]:  -> caused by: Permission denied (os error 13)
Feb 18 12:47:05 gateway snips-asr[3466]: ERROR:rumqtt::client  : snips-asr|3466-gateway-1 Disconnected: (Error(SyncMpsc(Disconnected), State { next_error: None, backtrace: None }))
Feb 18 12:47:05 gateway systemd[1]: snips-asr.service: Main process exited, code=exited, status=1/FAILURE
Feb 18 12:47:05 gateway systemd[1]: snips-asr.service: Unit entered failed state.
Feb 18 12:47:05 gateway systemd[1]: snips-asr.service: Failed with result 'exit-code'.
Feb 18 12:47:05 gateway systemd[1]: snips-hotword.service: Service hold-off time over, scheduling restart.
Feb 18 12:47:05 gateway systemd[1]: Stopped Snips Hotword.
Feb 18 12:47:05 gateway systemd[1]: Started Snips Hotword.
Feb 18 12:47:05 gateway snips-hotword[3480]: INFO:snips_hotword::server: Using model from /usr/share/snips/assistant/custom_hotword
Feb 18 12:47:05 gateway snips-hotword[3480]: ERROR:rumqtt::client       : snips-hotword|3480-gateway-1 Disconnected: (Error(SyncMpsc(Disconnected), State { next_error: None, backtrace: None }))
Feb 18 12:47:05 gateway snips-hotword[3480]: ERROR:snips_hotword        : Permission denied (os error 13)
Feb 18 12:47:05 gateway systemd[1]: snips-hotword.service: Main process exited, code=exited, status=1/FAILURE
Feb 18 12:47:05 gateway systemd[1]: snips-hotword.service: Unit entered failed state.
Feb 18 12:47:05 gateway systemd[1]: snips-hotword.service: Failed with result 'exit-code'.
Feb 18 12:47:06 gateway run-app.sh[509]: 2019-02-18 12:47:06.076 INFO   : voice-addon: DATA snips_installation: Processing triggers for man-db (2.7.6.1-2) ...
Feb 18 12:47:06 gateway run-app.sh[509]: 2019-02-18 12:47:06.077 INFO   : voice-addon: 
Feb 18 12:47:06 gateway systemd[1]: snips-dialogue.service: Service hold-off time over, scheduling restart.
Feb 18 12:47:06 gateway systemd[1]: Stopped Snips Dialogue.
Feb 18 12:47:06 gateway systemd[1]: Started Snips Dialogue.
Feb 18 12:47:06 gateway snips-dialogue[3565]: INFO:snips_dialogue_hermes: Loading the configuration file
Feb 18 12:47:06 gateway snips-dialogue[3565]: ERROR:rumqtt::client       : snips-dialogue|3565-gateway-1 Disconnected: (Error(SyncMpsc(Disconnected), State { next_error: None, backtrace: None }))
Feb 18 12:47:06 gateway snips-dialogue[3565]: ERROR:snips_dialogue       : couldn't read assistant file at path "/usr/share/snips/assistant/assistant.json"
Feb 18 12:47:06 gateway snips-dialogue[3565]:  -> caused by: Permission denied (os error 13)
Feb 18 12:47:06 gateway systemd[1]: snips-dialogue.service: Main process exited, code=exited, status=1/FAILURE
Feb 18 12:47:06 gateway systemd[1]: snips-dialogue.service: Unit entered failed state.
Feb 18 12:47:06 gateway systemd[1]: snips-dialogue.service: Failed with result 'exit-code'.
Feb 18 12:47:07 gateway run-app.sh[509]: 2019-02-18 12:47:07.328 INFO   : voice-addon: DATA snips_installation: Setting up python-pycparser (2.17-2) ...
Feb 18 12:47:07 gateway run-app.sh[509]: 2019-02-18 12:47:07.330 INFO   : voice-addon: 
Feb 18 12:47:07 gateway systemd[1]: snips-nlu.service: Service hold-off time over, scheduling restart.
Feb 18 12:47:07 gateway systemd[1]: Stopped Snips NLU.
Feb 18 12:47:07 gateway systemd[1]: Started Snips NLU.
Feb 18 12:47:07 gateway snips-nlu[3575]: INFO:snips_nlu_hermes: loading nlu engine "/usr/share/snips/assistant/nlu_engine"
Feb 18 12:47:07 gateway snips-nlu[3575]: ERROR:snips_nlu_hermes: nlu thread ended with error: Unable to read file '/usr/share/snips/assistant/nlu_engine/nlu_engine.json'
Feb 18 12:47:07 gateway snips-nlu[3575]:  -> caused by: Permission denied (os error 13)
Feb 18 12:47:07 gateway snips-nlu[3575]: ERROR:rumqtt::client  : snips-nlu|3575-gateway-1 Disconnected: (Error(SyncMpsc(Disconnected), State { next_error: None, backtrace: None }))
Feb 18 12:47:07 gateway snips-nlu[3575]: ERROR:snips_nlu       : Fail to wait end of pipeline
Feb 18 12:47:07 gateway snips-nlu[3575]:  -> caused by: Unable to read file '/usr/share/snips/assistant/nlu_engine/nlu_engine.json'
Feb 18 12:47:07 gateway snips-nlu[3575]:  -> caused by: Permission denied (os error 13)
Feb 18 12:47:07 gateway systemd[1]: snips-nlu.service: Main process exited, code=exited, status=1/FAILURE
Feb 18 12:47:07 gateway systemd[1]: snips-nlu.service: Unit entered failed state.
Feb 18 12:47:07 gateway systemd[1]: snips-nlu.service: Failed with result 'exit-code'.
Feb 18 12:47:08 gateway run-app.sh[509]: 2019-02-18 12:47:08.125 INFO   : voice-addon: DATA snips_installation: Setting up python-cffi (1.9.1-2) ...
Feb 18 12:47:08 gateway run-app.sh[509]: 2019-02-18 12:47:08.127 INFO   : voice-addon: 
Feb 18 12:47:08 gateway run-app.sh[509]: 2019-02-18 12:47:08.806 INFO   : voice-addon: DATA snips_installation: Setting up python-soundfile (0.8.1-2) ...
Feb 18 12:47:08 gateway run-app.sh[509]: 2019-02-18 12:47:08.807 INFO   : voice-addon: 
Feb 18 12:47:10 gateway systemd[1]: snips-asr.service: Service hold-off time over, scheduling restart.
Feb 18 12:47:10 gateway systemd[1]: Stopped Snips ASR.
Feb 18 12:47:10 gateway systemd[1]: Started Snips ASR.
Feb 18 12:47:10 gateway sudo[3378]: pam_unix(sudo:session): session closed for user root
Feb 18 12:47:10 gateway snips-asr[3597]: INFO:snips_asr: Connecting using MQTT site-id default
Feb 18 12:47:10 gateway snips-asr[3597]: INFO:snips_asr_hermes: Using model from "/usr/share/snips/assistant/custom_asr"
Feb 18 12:47:10 gateway snips-asr[3597]: ERROR:snips_asr_hermes: Asr main thread ended with error: A problem occurred with resources
Feb 18 12:47:10 gateway snips-asr[3597]:  -> caused by: An I/O error occurred
Feb 18 12:47:10 gateway snips-asr[3597]:  -> caused by: Permission denied (os error 13)
Feb 18 12:47:10 gateway snips-asr[3597]: ERROR:rumqtt::client  : snips-asr|3597-gateway-3 Disconnected: (Error(SyncMpsc(Disconnected), State { next_error: None, backtrace: None }))
Feb 18 12:47:10 gateway snips-asr[3597]: INFO:snips_asr       : Pipeline is finished
Feb 18 12:47:10 gateway snips-asr[3597]: ERROR:snips_asr       : A problem occurred with resources
Feb 18 12:47:10 gateway snips-asr[3597]:  -> caused by: An I/O error occurred
Feb 18 12:47:10 gateway snips-asr[3597]:  -> caused by: Permission denied (os error 13)
Feb 18 12:47:10 gateway systemd[1]: snips-asr.service: Main process exited, code=exited, status=1/FAILURE
Feb 18 12:47:10 gateway systemd[1]: snips-asr.service: Unit entered failed state.
Feb 18 12:47:10 gateway sudo[3603]:       pi : TTY=unknown ; PWD=/home/pi/.mozilla-iot/addons/voice-addon ; USER=root ; COMMAND=/bin/cp snips.toml /etc/
Feb 18 12:47:10 gateway systemd[1]: snips-asr.service: Failed with result 'exit-code'.
Feb 18 12:47:10 gateway sudo[3603]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 18 12:47:10 gateway sudo[3603]: pam_unix(sudo:session): session closed for user root
Feb 18 12:47:10 gateway sudo[3615]:       pi : TTY=unknown ; PWD=/home/pi/.mozilla-iot/addons/voice-addon ; USER=root ; COMMAND=/bin/chown -R _snips:_snips /usr/share/snips/assistant/
Feb 18 12:47:10 gateway sudo[3615]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 18 12:47:10 gateway sudo[3615]: pam_unix(sudo:session): session closed for user root
Feb 18 12:47:10 gateway sudo[3623]:       pi : TTY=unknown ; PWD=/home/pi/.mozilla-iot/addons/voice-addon ; USER=root ; COMMAND=/bin/systemctl restart snips-hotword
Feb 18 12:47:10 gateway sudo[3623]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 18 12:47:10 gateway systemd[1]: snips-hotword.service: Service hold-off time over, scheduling restart.
Feb 18 12:47:10 gateway systemd[1]: Stopped Snips Hotword.
Feb 18 12:47:10 gateway systemd[1]: Started Snips Hotword.
Feb 18 12:47:10 gateway systemd[1]: Stopping Snips Hotword...
Feb 18 12:47:10 gateway systemd[1]: Stopped Snips Hotword.
Feb 18 12:47:10 gateway systemd[1]: Started Snips Hotword.
Feb 18 12:47:11 gateway sudo[3623]: pam_unix(sudo:session): session closed for user root
Feb 18 12:47:11 gateway snips-hotword[3630]: INFO:snips_hotword::server: Using model from /home/pi/.mozilla-iot/addons/voice-addon/personal_kws/
Feb 18 12:47:11 gateway snips-hotword[3630]: INFO:snips_hotword_lib::universal: Loading model "/home/pi/.mozilla-iot/addons/voice-addon/personal_kws/", hotword_key: None, model_id: None
Feb 18 12:47:11 gateway sudo[3634]:       pi : TTY=unknown ; PWD=/home/pi/.mozilla-iot/addons/voice-addon ; USER=root ; COMMAND=/bin/systemctl restart snips-dialogue
Feb 18 12:47:11 gateway sudo[3634]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 18 12:47:11 gateway systemd[1]: Stopped Snips Dialogue.
Feb 18 12:47:11 gateway systemd[1]: Started Snips Dialogue.
Feb 18 12:47:11 gateway sudo[3634]: pam_unix(sudo:session): session closed for user root
Feb 18 12:47:11 gateway snips-dialogue[3640]: INFO:snips_dialogue_hermes: Loading the configuration file
Feb 18 12:47:11 gateway snips-dialogue[3640]: INFO:snips_dialogue_lib::config: Loading language en
Feb 18 12:47:11 gateway snips-dialogue[3640]: INFO:snips_dialogue_hermes     : Starting...
Feb 18 12:47:11 gateway sudo[3647]:       pi : TTY=unknown ; PWD=/home/pi/.mozilla-iot/addons/voice-addon ; USER=root ; COMMAND=/bin/systemctl restart snips-injection
Feb 18 12:47:11 gateway sudo[3647]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 18 12:47:11 gateway systemd[1]: Stopping Snips Injection...
Feb 18 12:47:11 gateway systemd[1]: Stopped Snips Injection.
Feb 18 12:47:11 gateway systemd[1]: Started Snips Injection.
Feb 18 12:47:11 gateway sudo[3647]: pam_unix(sudo:session): session closed for user root
Feb 18 12:47:11 gateway snips-hotword[3630]: INFO:snips_hotword::server       : Discovered audio_server default/mqtt, starting hotword listener
Feb 18 12:47:11 gateway snips-hotword[3630]: INFO:snips_hotword::server       : Connecting using MQTT site-id default
Feb 18 12:47:11 gateway snips-hotword[3630]: INFO:snips_hotword_lib::audio    : Audio thread for default started
Feb 18 12:47:11 gateway snips-hotword[3630]: INFO:snips_hotword_lib::audio    : Net and VAD thread for site default started (vad inhibitor: true, vad messages: false
Feb 18 12:47:11 gateway run-app.sh[509]: 2019-02-18 12:47:11.186 INFO   : voice-addon: DATA snips_installation: Setup complete
Feb 18 12:47:11 gateway snips-hotword[3630]: INFO:snips_hotword_lib           : Detector "detector.default.default", sensitivity: 0.5, threshold 0.47
Feb 18 12:47:11 gateway run-app.sh[509]: 2019-02-18 12:47:11.187 INFO   : voice-addon: 
Feb 18 12:47:11 gateway snips-hotword[3630]: INFO:snips_hotword_lib           : detector.default.default thread started
Feb 18 12:47:11 gateway snips-injection[3653]: INFO:snips_injection_hermes: Launch with assistant "/usr/share/snips/assistant" and user dir "/var/lib/snips/"
Feb 18 12:47:13 gateway systemd[1]: snips-nlu.service: Service hold-off time over, scheduling restart.
Feb 18 12:47:13 gateway systemd[1]: Stopped Snips NLU.
Feb 18 12:47:13 gateway systemd[1]: Started Snips NLU.
Feb 18 12:47:13 gateway snips-nlu[3663]: INFO:snips_nlu_hermes: loading nlu engine "/usr/share/snips/assistant/nlu_engine"
Feb 18 12:47:13 gateway run-app.sh[509]: 2019-02-18 12:47:13.640 ERROR  : voice-addon: problem with request: connect ECONNREFUSED 127.0.0.1:4443
Feb 18 12:47:14 gateway snips-nlu[3663]: INFO:snips_nlu_hermes: model loaded in 1240 ms
Feb 18 12:47:15 gateway systemd[1]: snips-asr.service: Service hold-off time over, scheduling restart.
Feb 18 12:47:15 gateway systemd[1]: Stopped Snips ASR.
Feb 18 12:47:15 gateway systemd[1]: Started Snips ASR.
Feb 18 12:47:16 gateway snips-asr[3666]: INFO:snips_asr: Connecting using MQTT site-id default
Feb 18 12:47:16 gateway snips-asr[3666]: INFO:snips_asr_hermes: Using model from "/usr/share/snips/assistant/custom_asr"
Feb 18 12:47:16 gateway snips-asr[3666]: INFO:snips_kaldi::decode::model: Loading model v2
Feb 18 12:47:16 gateway snips-asr[3666]: INFO:snips_asr_hermes          : Preparing decoder
Feb 18 12:47:16 gateway snips-asr[3666]: INFO:snips_asr_hermes          : Idle
Feb 18 12:47:23 gateway run-app.sh[509]: 2019-02-18 12:47:23.652 ERROR  : voice-addon: problem with request: connect ECONNREFUSED 127.0.0.1:4443
Feb 18 12:47:33 gateway run-app.sh[509]: 2019-02-18 12:47:33.657 ERROR  : voice-addon: problem with request: connect ECONNREFUSED 127.0.0.1:4443
Feb 18 12:47:43 gateway run-app.sh[509]: 2019-02-18 12:47:43.668 ERROR  : voice-addon: problem with request: connect ECONNREFUSED 127.0.0.1:4443
Feb 18 12:47:53 gateway run-app.sh[509]: 2019-02-18 12:47:53.680 ERROR  : voice-addon: problem with request: connect ECONNREFUSED 127.0.0.1:4443
Feb 18 12:48:03 gateway run-app.sh[509]: 2019-02-18 12:48:03.692 ERROR  : voice-addon: problem with request: connect ECONNREFUSED 127.0.0.1:4443
Feb 18 12:48:13 gateway run-app.sh[509]: 2019-02-18 12:48:13.701 ERROR  : voice-addon: problem with request: connect ECONNREFUSED 127.0.0.1:4443
Feb 18 12:48:23 gateway run-app.sh[509]: 2019-02-18 12:48:23.713 ERROR  : voice-addon: problem with request: connect ECONNREFUSED 127.0.0.1:4443
Feb 18 12:48:33 gateway run-app.sh[509]: 2019-02-18 12:48:33.718 ERROR  : voice-addon: problem with request: connect ECONNREFUSED 127.0.0.1:4443
flatsiedatsie commented 5 years ago

I realized I hadn't added the json code in the fresh install. But it made no difference. Neither did a reboot.

andrenatal commented 5 years ago

Hy @flatsiedatsie We have a new version (1.0.0) about to land. Would you mind please testing it? This issue was fixed. Before doing it, is better to remove your current version of snips (apt-get remove snips*)

Thanks!