Home Assistant Community

Cannot restart Hassio (docker) from CLI - Unknown Error

#1

Today I noticed my lights did not shut off last night per the automations. In the web interface, the automations said they fired, but the object of the automations were still on.

I tried to restart ha from the SSH CLI and after hanging for about 10 minutes I finally got this:

core-ssh:~# hassio homeassistant restart
ERROR
Unknown Error, see logs

The first line of the log says the following that I cannot decifer:

Error decoding json invalid character ‘-’ after top-level value:

I have some platform names that include a “-”, but they have been working for months without issue:

  - platform: mqtt
      name: "Low Voltage Lights - South"
      state_topic: "stat/lowvoltagelights/south/POWER"
      command_topic: "cmnd/lowvoltagelights/south/POWER"
      qos: 1
      payload_on: "ON"
      payload_off: "OFF"
      retain: true

I can no longer connect to the web interface, either through http://192.168.1.180:8123/ or DuckDNS. The web interface shows:

A connection attempt was refused.
http://192.168.1.180:8123/

I have tried toggling power to the the RaspPI

  • I have access to Samba shares
  • I have access to SSH CLI
  • Validity checks from CLI are “OK”

Other info:

core-ssh:~# hassio homeassistant info
{
“result”: “ok”,
“data”: {
“version”: “0.79.3”,
“last_version”: “0.79.3”,
“machine”: “raspberrypi3”,
“image”: “homeassistant/raspberrypi3-homeassistant”,
“custom”: false,
“boot”: true,
“port”: 8123,
“ssl”: true,
“watchdog”: true,
“wait_boot”: 600
}
}

Log:

core-ssh:~# hassio homeassistant logs
Error decoding json invalid character '-' after top-level value: 
2018-10-08 07:52:39 INFO (MainThread) [homeassistant.setup] Setup of domain frontend took 3.0 seconds.
2018-10-08 07:52:40 WARNING (Recorder) [homeassistant.components.recorder] Ended unfinished session (id=356 from 2018-10-08 14:34:25.390655)
2018-10-08 07:52:40 INFO (MainThread) [homeassistant.setup] Setup of domain recorder took 3.6 seconds.
2018-10-08 07:52:40 INFO (MainThread) [homeassistant.setup] Setting up history
2018-10-08 07:52:40 INFO (MainThread) [homeassistant.setup] Setup of domain history took 0.0 seconds.
2018-10-08 07:52:40 INFO (MainThread) [homeassistant.loader] Loaded tts from homeassistant.components.tts
2018-10-08 07:52:40 INFO (MainThread) [homeassistant.loader] Loaded tts.google from homeassistant.components.tts.google
2018-10-08 07:52:40 INFO (MainThread) [homeassistant.loader] Loaded switch from homeassistant.components.switch
2018-10-08 07:52:40 INFO (MainThread) [homeassistant.loader] Loaded group from homeassistant.components.group
2018-10-08 07:52:40 INFO (MainThread) [homeassistant.loader] Loaded switch.mqtt from homeassistant.components.switch.mqtt
2018-10-08 07:52:40 INFO (MainThread) [homeassistant.loader] Loaded automation from homeassistant.components.automation
2018-10-08 07:52:40 INFO (MainThread) [homeassistant.loader] Loaded sensor from homeassistant.components.sensor
2018-10-08 07:52:40 INFO (MainThread) [homeassistant.loader] Loaded sensor.wunderground from homeassistant.components.sensor.wunderground
2018-10-08 07:52:40 INFO (MainThread) [homeassistant.setup] Setting up sensor
2018-10-08 07:52:40 INFO (MainThread) [homeassistant.loader] Loaded hassio from homeassistant.components.hassio
2018-10-08 07:52:40 INFO (MainThread) [homeassistant.loader] Loaded device_tracker from homeassistant.components.device_tracker
2018-10-08 07:52:40 INFO (MainThread) [homeassistant.loader] Loaded zone from homeassistant.components.zone
2018-10-08 07:52:40 INFO (MainThread) [homeassistant.loader] Loaded device_tracker.owntracks from homeassistant.components.device_tracker.owntracks
2018-10-08 07:52:40 INFO (MainThread) [homeassistant.loader] Loaded device_tracker.netgear from homeassistant.components.device_tracker.netgear
2018-10-08 07:52:40 INFO (MainThread) [homeassistant.loader] Loaded map from homeassistant.components.map
2018-10-08 07:52:40 INFO (MainThread) [homeassistant.setup] Setting up map
2018-10-08 07:52:40 INFO (MainThread) [homeassistant.setup] Setup of domain map took 0.0 seconds.
2018-10-08 07:52:40 INFO (MainThread) [homeassistant.loader] Loaded updater from homeassistant.components.updater
2018-10-08 07:52:40 INFO (MainThread) [homeassistant.setup] Setting up updater
2018-10-08 07:52:40 INFO (MainThread) [homeassistant.loader] Loaded cast from homeassistant.components.cast
2018-10-08 07:52:40 INFO (MainThread) [homeassistant.setup] Setting up cast
2018-10-08 07:52:40 INFO (MainThread) [homeassistant.setup] Setup of domain cast took 0.0 seconds.
2018-10-08 07:52:40 INFO (MainThread) [homeassistant.loader] Loaded conversation from homeassistant.components.conversation
2018-10-08 07:52:40 INFO (MainThread) [homeassistant.loader] Loaded config from homeassistant.components.config
2018-10-08 07:52:40 INFO (MainThread) [homeassistant.loader] Loaded logbook from homeassistant.components.logbook
2018-10-08 07:52:40 INFO (MainThread) [homeassistant.setup] Setting up group
2018-10-08 07:52:40 INFO (MainThread) [homeassistant.loader] Loaded sun from homeassistant.components.sun
2018-10-08 07:52:40 INFO (MainThread) [homeassistant.setup] Setting up sun
2018-10-08 07:52:40 INFO (MainThread) [homeassistant.setup] Setup of domain sun took 0.1 seconds.
2018-10-08 07:52:40 INFO (MainThread) [homeassistant.setup] Setting up zone
2018-10-08 07:52:40 INFO (MainThread) [homeassistant.setup] Setup of domain zone took 0.0 seconds.
2018-10-08 07:52:40 INFO (MainThread) [homeassistant.loader] Loaded ifttt from homeassistant.components.ifttt
2018-10-08 07:52:40 INFO (MainThread) [homeassistant.setup] Setting up ifttt
2018-10-08 07:52:40 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.wunderground
2018-10-08 07:52:40 INFO (MainThread) [homeassistant.setup] Setup of domain updater took 0.3 seconds.
2018-10-08 07:52:40 INFO (MainThread) [homeassistant.loader] Loaded media_player from homeassistant.components.media_player
2018-10-08 07:52:40 INFO (MainThread) [homeassistant.setup] Setting up tts
2018-10-08 07:52:40 INFO (MainThread) [homeassistant.setup] Setting up hassio
2018-10-08 07:52:40 INFO (MainThread) [homeassistant.setup] Setting up conversation
2018-10-08 07:52:41 INFO (MainThread) [homeassistant.setup] Setup of domain conversation took 0.0 seconds.
2018-10-08 07:52:41 INFO (MainThread) [homeassistant.setup] Setting up config
2018-10-08 07:52:41 INFO (MainThread) [homeassistant.setup] Setting up logbook
2018-10-08 07:52:41 INFO (MainThread) [homeassistant.setup] Setup of domain logbook took 0.0 seconds.
2018-10-08 07:52:41 INFO (MainThread) [homeassistant.setup] Setup of domain ifttt took 0.2 seconds.
2018-10-08 07:52:41 INFO (MainThread) [homeassistant.loader] Loaded config.automation from homeassistant.components.config.automation
2018-10-08 07:52:41 INFO (MainThread) [homeassistant.loader] Loaded config.customize from homeassistant.components.config.customize
2018-10-08 07:52:41 INFO (MainThread) [homeassistant.loader] Loaded config.entity_registry from homeassistant.components.config.entity_registry
2018-10-08 07:52:41 INFO (MainThread) [homeassistant.loader] Loaded config.device_registry from homeassistant.components.config.device_registry
2018-10-08 07:52:41 INFO (MainThread) [homeassistant.loader] Loaded config.group from homeassistant.components.config.group
2018-10-08 07:52:41 INFO (MainThread) [homeassistant.loader] Loaded config.config_entries from homeassistant.components.config.config_entries
2018-10-08 07:52:41 INFO (MainThread) [homeassistant.loader] Loaded config.hassbian from homeassistant.components.config.hassbian
2018-10-08 07:52:41 INFO (MainThread) [homeassistant.loader] Loaded config.script from homeassistant.components.config.script
2018-10-08 07:52:41 INFO (MainThread) [homeassistant.loader] Loaded config.auth from homeassistant.components.config.auth
2018-10-08 07:52:41 INFO (MainThread) [homeassistant.loader] Loaded config.auth_provider_homeassistant from homeassistant.components.config.auth_provider_homeassistant
2018-10-08 07:52:41 INFO (MainThread) [homeassistant.loader] Loaded config.core from homeassistant.components.config.core
2018-10-08 07:52:41 INFO (MainThread) [homeassistant.setup] Setting up media_player
2018-10-08 07:52:41 INFO (MainThread) [homeassistant.setup] Setup of domain media_player took 0.0 seconds.
2018-10-08 07:52:41 INFO (MainThread) [homeassistant.loader] Loaded media_player.cast from homeassistant.components.media_player.cast
2018-10-08 07:52:41 INFO (MainThread) [homeassistant.components.media_player] Setting up media_player.cast
2018-10-08 07:52:41 INFO (MainThread) [homeassistant.setup] Setup of domain config took 0.2 seconds.
2018-10-08 07:52:41 INFO (MainThread) [homeassistant.setup] Setup of domain tts took 0.3 seconds.
2018-10-08 07:52:41 INFO (MainThread) [homeassistant.loader] Loaded panel_custom from homeassistant.components.panel_custom
2018-10-08 07:52:41 INFO (SyncWorker_2) [pychromecast] Querying device status
2018-10-08 07:52:41 INFO (SyncWorker_12) [pychromecast] Querying device status
2018-10-08 07:52:41 INFO (MainThread) [homeassistant.setup] Setup of domain sensor took 1.2 seconds.
2018-10-08 07:52:41 INFO (MainThread) [homeassistant.setup] Setup of domain hassio took 0.8 seconds.
2018-10-08 07:52:41 ERROR (SyncWorker_2) [pychromecast.socket_client] Failed to connect, retrying in 5.0s
2018-10-08 07:52:41 INFO (SyncWorker_6) [pychromecast] Querying device status
2018-10-08 07:52:41 INFO (MainThread) [homeassistant.setup] Setup of domain group took 1.1 seconds.
2018-10-08 07:52:41 INFO (MainThread) [homeassistant.setup] Setting up switch
2018-10-08 07:52:41 INFO (MainThread) [homeassistant.setup] Setting up automation
2018-10-08 07:52:41 INFO (MainThread) [homeassistant.setup] Setting up device_tracker
2018-10-08 07:52:41 INFO (MainThread) [homeassistant.components.switch] Setting up switch.mqtt
2018-10-08 07:52:41 INFO (MainThread) [homeassistant.components.switch] Setting up switch.mqtt
2018-10-08 07:52:41 INFO (MainThread) [homeassistant.components.switch] Setting up switch.mqtt
2018-10-08 07:52:41 INFO (MainThread) [homeassistant.components.switch] Setting up switch.mqtt
2018-10-08 07:52:41 INFO (MainThread) [homeassistant.components.switch] Setting up switch.mqtt
2018-10-08 07:52:41 INFO (MainThread) [homeassistant.components.switch] Setting up switch.mqtt
2018-10-08 07:52:42 INFO (MainThread) [homeassistant.setup] Setup of domain automation took 0.8 seconds.
2018-10-08 07:52:42 INFO (MainThread) [homeassistant.setup] Setup of domain switch took 0.9 seconds.
2018-10-08 07:52:43 INFO (MainThread) [homeassistant.components.device_tracker] Setting up device_tracker.netgear
2018-10-08 07:52:43 INFO (MainThread) [homeassistant.components.device_tracker] Setting up device_tracker.owntracks
2018-10-08 07:52:43 ERROR (MainThread) [homeassistant.components.device_tracker.owntracks] Unable to parse payload as JSON: Hello
2018-10-08 07:52:43 INFO (SyncWorker_8) [homeassistant.components.device_tracker.netgear] Logging in
2018-10-08 07:52:43 INFO (SyncWorker_8) [pynetgear] Get attached devices
2018-10-08 07:52:43 INFO (SyncWorker_8) [pynetgear] Login
2018-10-08 07:52:44 INFO (SyncWorker_4) [pychromecast] Querying device status
2018-10-08 07:52:44 INFO (SyncWorker_18) [pychromecast] Querying device status
2018-10-08 07:52:44 INFO (SyncWorker_9) [pychromecast] Querying device status
2018-10-08 07:52:45 INFO (SyncWorker_19) [pychromecast] Querying device status
2018-10-08 07:52:45 INFO (SyncWorker_5) [pychromecast] Querying device status
2018-10-08 07:52:47 INFO (SyncWorker_11) [pychromecast] Querying device status
2018-10-08 07:52:48 INFO (SyncWorker_10) [homeassistant.components.device_tracker.netgear] Scanning
2018-10-08 07:52:48 INFO (SyncWorker_10) [pynetgear] Get attached devices
2018-10-08 07:52:48 INFO (MainThread) [homeassistant.setup] Setup of domain device_tracker took 6.5 seconds.
#2

Found this article searching for clues:

mikegrb recommended this:

I don’t know enough to understand what this is about, but after renaming the file and running a restart from the CLI, it restarted very fast and the Web UI was back up. A new core.config_entries file was created automatically. Mine contained information about Chromcast and MQTT.

I still had this in my logs:
Error decoding json invalid character ‘-’ after top-level value:
And I do not see any Google Cast devices in the Web UI.
I will have to search that some more.

Thanks to mikegrb!