Need a little help to set up a switch initially

[drock1985]

Hi @martinhjelmare

Yes, that is correct about only sending the one message. But, when that one switch gets toggled, the other two became active and sent their respective messages to Home-Assistant. The script that I had posted does work, but I do see what improvements you suggest. I meant to add them in originally - must have hurried through them. Next time i am in front of my PC, i'll make those changes.

I have a question about Home-Assistant maybe you can answer. I want to build a scene-controller to start having hardware control over my switches. Does Home-assistant and your plug-in support scene controllers? I don't see what is and what isn't supported for the API calls between the two.

Thanks,

[martinhjelmare]

@drock1985

Scene control is supported by a sensor in HA. I updated the docs. See the sensor and switch sub pages for mysensors at https://home-assistant.io. Let me know if it works as you like it or not.

[drock1985]

Hi @martinhjelmare

I've started to put together a simple 4x4 keypad scene controller, but I am running into issues when it connects to Home-Assistant. The scene controller sketch I am using is this which is based off PeteWill's that is linked on the main page, only with more buttons. The Scene Controller connects to HA and gets assinged a node ID, and I can send in commands but after that Home-Assistant freezes up and stops reacting to anything related to MySensors. In the end, I have to reboot the Home-Assistant service for everything else on my MySensors network to work again.

/**
 * The MySensors Arduino library handles the wireless radio link and protocol
 * between your home built sensors/actuators and HA controller of choice.
 * The sensors forms a self healing radio network with optional repeaters. Each
 * repeater and gateway builds a routing tables in EEPROM which keeps track of the
 * network topology allowing messages to be routed to nodes.
 *
 * Created by Henrik Ekblad <henrik.ekblad@mysensors.org>
 * Copyright (C) 2013-2015 Sensnology AB
 * Full contributor list: https://github.com/mysensors/Arduino/graphs/contributors
 *
 * Documentation: http://www.mysensors.org
 * Support Forum: http://forum.mysensors.org
 *
 * This program is free software; you can redistribute it and/or
 * modify it under the terms of the GNU General Public License
 * version 2 as published by the Free Software Foundation.
 *
 *******************************
 *
 * REVISION HISTORY
 * Version 1.0 - Derrick Rockwell
 * Bassed off PeteWill's 4x1Scene Controller. This one uses the 4x4 keypad and Analog
 * pings A0 to A3. 
 * 
 * DESCRIPTION
 * A simple scene controller for use with MySensors.  8 scenes can be executed.
 * 4 with short button presses and 4 with long button presses (held .5 seconds or more).
 * Watch a how to video here: https://youtu.be/KMGj5Bi7vL0 
 */

#include <Keypad.h>
#include <SPI.h>
#include <MySensor.h>

#define NODE_ID AUTO // or set to AUTO if you want gw to assign a NODE_ID for you.
#define SN "Scene Controller"
#define SV "1.0"


#define KEYPAD_CHILD_ID 0

MySensor gw;
MyMessage scene(KEYPAD_CHILD_ID, V_SCENE_ON);

const byte ROWS = 4; //four rows
const byte COLS = 4; //three columns
char keys[ROWS][COLS] = {
  {'1','2','3','A'},
  {'4','5','6','B'},
  {'7','8','9','C'},
  {'*','0','#','D'}
};

byte rowPins[ROWS] = {3, 4, 5, 6}; //connect to the row pinouts of the keypad
byte colPins[COLS] = {A0, A1, A2, A3}; //connect to the column pinouts of the keypad

Keypad keypad = Keypad( makeKeymap(keys), rowPins, colPins, ROWS, COLS );
byte lastState;


void setup() {
  gw.begin(NULL, NODE_ID);
  gw.sendSketchInfo(SN, SV);
  gw.present(KEYPAD_CHILD_ID, S_SCENE_CONTROLLER);
  keypad.addEventListener(keypadEvent); // Add an event listener for this keypad
}

void loop() {
  char key = keypad.getKey();
}

void keypadEvent(KeypadEvent key) {
  switch (keypad.getState()) {

    case PRESSED:
      lastState = 1;
      break;

    case HOLD:
      lastState = 2;
      break;

    case RELEASED:
      int keyInt = key - '0'; //Quick way to convert Char to Int so it can be sent to controller
      if (lastState == 2) {
        keyInt = keyInt + 10; //If button is held, add 4.  If using more than 4 buttons this number will need to be changed
      }
      gw.send(scene.set(keyInt));
      break;
  }
}

This is the log from the ARduino IDE when connecting and pressing the buttons on the keypad. Not sure if it is me or not.

send: 9-9-0-0 s=255,c=0,t=17,pt=0,l=5,sg=0,st=ok:1.5.1
send: 9-9-0-0 s=255,c=3,t=6,pt=1,l=1,sg=0,st=ok:0
sensor started, id=9, parent=0, distance=1
send: 9-9-0-0 s=255,c=3,t=11,pt=0,l=16,sg=0,st=ok:Scene Controller
send: 9-9-0-0 s=255,c=3,t=12,pt=0,l=3,sg=0,st=ok:1.0
send: 9-9-0-0 s=0,c=0,t=25,pt=0,l=0,sg=0,st=ok:
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:-6
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:-6
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:-13
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:-13
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:20
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:19
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:18
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:17
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:1
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:1
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:1
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:1
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:2
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:3
send: 9-9-0-0 s=255,c=0,t=17,pt=0,l=5,sg=0,st=ok:1.5.1
send: 9-9-0-0 s=255,c=3,t=6,pt=1,l=1,sg=0,st=ok:0
read: 0-0-9 s=255,c=3,t=6,pt=0,l=1,sg=0:M
sensor started, id=9, parent=0, distance=1
send: 9-9-0-0 s=255,c=3,t=11,pt=0,l=16,sg=0,st=ok:Scene Controller
send: 9-9-0-0 s=255,c=3,t=12,pt=0,l=3,sg=0,st=ok:1.0
send: 9-9-0-0 s=0,c=0,t=25,pt=0,l=0,sg=0,st=ok:
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:1
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:2
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:3
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:17
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:18
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:19
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:20
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:27
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:18
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:18
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:17
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:17
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:27
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:28
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:29
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:30
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:-6
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:4
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:4
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:-6
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:-6
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:-6
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:-13
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:-13
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:-3
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:-3
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:20
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:20
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:20
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:20
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:20
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:20
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:20
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:20
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:20
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:20
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:20
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:20

And this is where the output stops in the HA log when trying to send a command from the Scene Controller:

Feb 09 19:20:40 raspberrypi hass[10783]: INFO:homeassistant.components.media_player:Updating media_player entities
Feb 09 19:20:40 raspberrypi hass[10783]: INFO:homeassistant.components.mysensors:update sensor_update: node 9
Feb 09 19:20:40 raspberrypi hass[10783]: INFO:homeassistant.components.mysensors:No sketch_name: node 9
Feb 09 19:20:40 raspberrypi hass[10783]: INFO:homeassistant.components.mysensors:No sketch_name: node 9

[martinhjelmare]

@drock1985

Does the sensor show up in the gui? The log says "No sketch_name" when node 9 updates. That's an indication that all the presentation messages haven't been received. At least not sketch name. Do you have the full log after start of home assistant?

[drock1985]

@martinhjelmare

Hi,

No the sensor doesn't show in the GUI. When the node presents itself, that is when Home-Assistant looses all connection/activity with MySensors. This is the output from Home-Assistant log. In it, I switched on and off the lights discussed in this thread, and that worked fine. I then started up the node connected to my PC on the Arduino IDE and this is where activity for HA and MySensors stops. I tried to turn on and off the lights, but no output in the log.

pi@raspberrypi:~ $ clear
pi@raspberrypi:~ $ sudo journalctl -f -u home-assistant
-- Logs begin at Tue 2016-02-09 13:21:39 UTC. --
Feb 10 02:52:00 raspberrypi hass[14964]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.117
Feb 10 02:52:10 raspberrypi hass[14964]: INFO:homeassistant.components.media_player:Updating media_player entities
Feb 10 02:52:20 raspberrypi hass[14964]: INFO:homeassistant.components.media_player:Updating media_player entities
Feb 10 02:52:30 raspberrypi hass[14964]: INFO:homeassistant.components.media_player:Updating media_player entities
Feb 10 02:52:30 raspberrypi hass[14964]: INFO:homeassistant.components.light:Updating light entities
Feb 10 02:52:30 raspberrypi hass[14964]: INFO:homeassistant.components.camera:Updating camera entities
Feb 10 02:52:30 raspberrypi hass[14964]: INFO:homeassistant.core:Bus:Handling <Event state_changed[L]: old_state=<state camera.livingroom_cam=idle; friendly_name=LivingRoom Cam, entity_picture=/api/camera_proxy/camera.livingroom_cam?time=1455072720.5229504 @ 22:50:02 09-02-2016>, new_state=<state camera.livingroom_cam=idle; friendly_name=LivingRoom Cam, entity_picture=/api/camera_proxy/camera.livingroom_cam?time=1455072750.538427 @ 22:50:02 09-02-2016>, entity_id=camera.livingroom_cam>
Feb 10 02:52:30 raspberrypi hass[14964]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.117
Feb 10 02:52:30 raspberrypi hass[14964]: INFO:homeassistant.core:Bus:Handling <Event state_changed[L]: old_state=<state sun.sun=below_horizon; next_setting=21:39:26 10-02-2016, next_rising=11:25:09 10-02-2016, friendly_name=Sun, elevation=-53.29 @ 22:50:02 09-02-2016>, new_state=<state sun.sun=below_horizon; next_setting=21:39:26 10-02-2016, next_rising=11:25:09 10-02-2016, friendly_name=Sun, elevation=-53.42 @ 22:50:02 09-02-2016>, entity_id=sun.sun>
Feb 10 02:52:40 raspberrypi hass[14964]: INFO:homeassistant.components.media_player:Updating media_player entities
Feb 10 02:52:50 raspberrypi hass[14964]: INFO:homeassistant.components.media_player:Updating media_player entities
Feb 10 02:53:00 raspberrypi hass[14964]: INFO:homeassistant.components.media_player:Updating media_player entities
Feb 10 02:53:00 raspberrypi hass[14964]: INFO:homeassistant.components.light:Updating light entities
Feb 10 02:53:00 raspberrypi hass[14964]: INFO:homeassistant.components.camera:Updating camera entities
Feb 10 02:53:00 raspberrypi hass[14964]: INFO:homeassistant.core:Bus:Handling <Event state_changed[L]: old_state=<state camera.livingroom_cam=idle; friendly_name=LivingRoom Cam, entity_picture=/api/camera_proxy/camera.livingroom_cam?time=1455072750.538427 @ 22:50:02 09-02-2016>, new_state=<state camera.livingroom_cam=idle; friendly_name=LivingRoom Cam, entity_picture=/api/camera_proxy/camera.livingroom_cam?time=1455072780.5222528 @ 22:50:02 09-02-2016>, entity_id=camera.livingroom_cam>
Feb 10 02:53:01 raspberrypi hass[14964]: INFO:homeassistant.core:Bus:Handling <Event call_service[L]: service=turn_on, service_call_id=1981506480-5, domain=homeassistant, entity_id=switch.holidayleddesklights_30>
Feb 10 02:53:01 raspberrypi hass[14964]: INFO:homeassistant.core:Bus:Handling <Event call_service[L]: service_call_id=1981506480-6, service=turn_on, domain=switch, entity_id=['switch.holidayleddesklights_30']>
Feb 10 02:53:01 raspberrypi hass[14964]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.117
Feb 10 02:53:01 raspberrypi hass[14964]: INFO:homeassistant.core:Bus:Handling <Event state_changed[L]: old_state=<state switch.holidayleddesklights_30=off; node_id=3, V_PERCENTAGE=0, child_id=0, friendly_name=HolidayLEDDeskLights 3.0, battery_level=0, port=/dev/ttyUSB0 @ 22:50:23 09-02-2016>, new_state=<state switch.holidayleddesklights_30=on; node_id=3, V_PERCENTAGE=0, child_id=0, friendly_name=HolidayLEDDeskLights 3.0, battery_level=0, port=/dev/ttyUSB0 @ 22:53:01 09-02-2016>, entity_id=switch.holidayleddesklights_30>
Feb 10 02:53:01 raspberrypi hass[14964]: INFO:homeassistant.core:Bus:Handling <Event service_executed[L]: service_call_id=1981506480-6>
Feb 10 02:53:01 raspberrypi hass[14964]: INFO:homeassistant.core:Bus:Handling <Event service_executed[L]: service_call_id=1981506480-5>
Feb 10 02:53:01 raspberrypi hass[14964]: INFO:homeassistant.components.http:"POST /api/services/homeassistant/turn_on HTTP/1.1" 200 -
Feb 10 02:53:02 raspberrypi hass[14964]: INFO:homeassistant.components.mysensors:update sensor_update: node 3
Feb 10 02:53:02 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.0: value_type 2, value = 1
Feb 10 02:53:02 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.0: value_type 3, value = 0
Feb 10 02:53:02 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.1: value_type 2, value = 0
Feb 10 02:53:02 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.1: value_type 3, value = 0
Feb 10 02:53:02 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.2: value_type 2, value = 0
Feb 10 02:53:02 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.2: value_type 3, value = 0
Feb 10 02:53:02 raspberrypi hass[14964]: INFO:homeassistant.components.mysensors:update sensor_update: node 3
Feb 10 02:53:02 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.0: value_type 2, value = 1
Feb 10 02:53:02 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.0: value_type 3, value = 100
Feb 10 02:53:02 raspberrypi hass[14964]: INFO:homeassistant.core:Bus:Handling <Event state_changed[L]: old_state=<state switch.holidayleddesklights_30=on; node_id=3, V_PERCENTAGE=0, child_id=0, friendly_name=HolidayLEDDeskLights 3.0, battery_level=0, port=/dev/ttyUSB0 @ 22:53:01 09-02-2016>, new_state=<state switch.holidayleddesklights_30=on; node_id=3, V_PERCENTAGE=100, child_id=0, friendly_name=HolidayLEDDeskLights 3.0, battery_level=0, port=/dev/ttyUSB0 @ 22:53:01 09-02-2016>, entity_id=switch.holidayleddesklights_30>
Feb 10 02:53:02 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.1: value_type 2, value = 0
Feb 10 02:53:02 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.1: value_type 3, value = 0
Feb 10 02:53:02 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.2: value_type 2, value = 0
Feb 10 02:53:02 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.2: value_type 3, value = 0
Feb 10 02:53:03 raspberrypi hass[14964]: INFO:homeassistant.components.mysensors:update sensor_update: node 3
Feb 10 02:53:03 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.0: value_type 2, value = 1
Feb 10 02:53:03 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.0: value_type 3, value = 100
Feb 10 02:53:03 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.1: value_type 2, value = 1
Feb 10 02:53:03 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.1: value_type 3, value = 0
Feb 10 02:53:03 raspberrypi hass[14964]: INFO:homeassistant.core:Bus:Handling <Event state_changed[L]: old_state=<state switch.holidayleddesklights_31=off; node_id=3, V_PERCENTAGE=0, child_id=1, friendly_name=HolidayLEDDeskLights 3.1, battery_level=0, port=/dev/ttyUSB0 @ 22:50:26 09-02-2016>, new_state=<state switch.holidayleddesklights_31=on; node_id=3, V_PERCENTAGE=0, child_id=1, friendly_name=HolidayLEDDeskLights 3.1, battery_level=0, port=/dev/ttyUSB0 @ 22:53:03 09-02-2016>, entity_id=switch.holidayleddesklights_31>
Feb 10 02:53:03 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.2: value_type 2, value = 0
Feb 10 02:53:03 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.2: value_type 3, value = 0
Feb 10 02:53:03 raspberrypi hass[14964]: INFO:homeassistant.components.mysensors:update sensor_update: node 3
Feb 10 02:53:03 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.0: value_type 2, value = 1
Feb 10 02:53:03 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.0: value_type 3, value = 100
Feb 10 02:53:03 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.1: value_type 2, value = 1
Feb 10 02:53:03 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.1: value_type 3, value = 100
Feb 10 02:53:03 raspberrypi hass[14964]: INFO:homeassistant.core:Bus:Handling <Event state_changed[L]: old_state=<state switch.holidayleddesklights_31=on; node_id=3, V_PERCENTAGE=0, child_id=1, friendly_name=HolidayLEDDeskLights 3.1, battery_level=0, port=/dev/ttyUSB0 @ 22:53:03 09-02-2016>, new_state=<state switch.holidayleddesklights_31=on; node_id=3, V_PERCENTAGE=100, child_id=1, friendly_name=HolidayLEDDeskLights 3.1, battery_level=0, port=/dev/ttyUSB0 @ 22:53:03 09-02-2016>, entity_id=switch.holidayleddesklights_31>
Feb 10 02:53:03 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.2: value_type 2, value = 0
Feb 10 02:53:03 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.2: value_type 3, value = 0
Feb 10 02:53:04 raspberrypi hass[14964]: INFO:homeassistant.components.mysensors:update sensor_update: node 3
Feb 10 02:53:04 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.0: value_type 2, value = 1
Feb 10 02:53:04 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.0: value_type 3, value = 100
Feb 10 02:53:04 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.1: value_type 2, value = 1
Feb 10 02:53:04 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.1: value_type 3, value = 100
Feb 10 02:53:04 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.2: value_type 2, value = 1
Feb 10 02:53:04 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.2: value_type 3, value = 0
Feb 10 02:53:04 raspberrypi hass[14964]: INFO:homeassistant.core:Bus:Handling <Event state_changed[L]: old_state=<state switch.holidayleddesklights_32=off; node_id=3, V_PERCENTAGE=0, child_id=2, friendly_name=HolidayLEDDeskLights 3.2, battery_level=0, port=/dev/ttyUSB0 @ 22:50:27 09-02-2016>, new_state=<state switch.holidayleddesklights_32=on; node_id=3, V_PERCENTAGE=0, child_id=2, friendly_name=HolidayLEDDeskLights 3.2, battery_level=0, port=/dev/ttyUSB0 @ 22:53:04 09-02-2016>, entity_id=switch.holidayleddesklights_32>
Feb 10 02:53:04 raspberrypi hass[14964]: INFO:homeassistant.components.mysensors:update sensor_update: node 3
Feb 10 02:53:04 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.0: value_type 2, value = 1
Feb 10 02:53:04 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.0: value_type 3, value = 100
Feb 10 02:53:04 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.1: value_type 2, value = 1
Feb 10 02:53:04 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.1: value_type 3, value = 100
Feb 10 02:53:04 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.2: value_type 2, value = 1
Feb 10 02:53:04 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.2: value_type 3, value = 100
Feb 10 02:53:04 raspberrypi hass[14964]: INFO:homeassistant.core:Bus:Handling <Event state_changed[L]: old_state=<state switch.holidayleddesklights_32=on; node_id=3, V_PERCENTAGE=0, child_id=2, friendly_name=HolidayLEDDeskLights 3.2, battery_level=0, port=/dev/ttyUSB0 @ 22:53:04 09-02-2016>, new_state=<state switch.holidayleddesklights_32=on; node_id=3, V_PERCENTAGE=100, child_id=2, friendly_name=HolidayLEDDeskLights 3.2, battery_level=0, port=/dev/ttyUSB0 @ 22:53:04 09-02-2016>, entity_id=switch.holidayleddesklights_32>
Feb 10 02:53:10 raspberrypi hass[14964]: INFO:homeassistant.components.media_player:Updating media_player entities
Feb 10 02:53:14 raspberrypi hass[14964]: INFO:homeassistant.core:Bus:Handling <Event call_service[L]: service=turn_off, service_call_id=1981506480-7, domain=homeassistant, entity_id=switch.holidayleddesklights_30>
Feb 10 02:53:14 raspberrypi hass[14964]: INFO:homeassistant.core:Bus:Handling <Event call_service[L]: service_call_id=1981506480-8, service=turn_off, domain=switch, entity_id=['switch.holidayleddesklights_30']>
Feb 10 02:53:14 raspberrypi hass[14964]: INFO:homeassistant.core:Bus:Handling <Event state_changed[L]: old_state=<state switch.holidayleddesklights_30=on; node_id=3, V_PERCENTAGE=100, child_id=0, friendly_name=HolidayLEDDeskLights 3.0, battery_level=0, port=/dev/ttyUSB0 @ 22:53:01 09-02-2016>, new_state=<state switch.holidayleddesklights_30=off; node_id=3, V_PERCENTAGE=100, child_id=0, friendly_name=HolidayLEDDeskLights 3.0, battery_level=0, port=/dev/ttyUSB0 @ 22:53:14 09-02-2016>, entity_id=switch.holidayleddesklights_30>
Feb 10 02:53:14 raspberrypi hass[14964]: INFO:homeassistant.core:Bus:Handling <Event service_executed[L]: service_call_id=1981506480-8>
Feb 10 02:53:14 raspberrypi hass[14964]: INFO:homeassistant.core:Bus:Handling <Event service_executed[L]: service_call_id=1981506480-7>
Feb 10 02:53:14 raspberrypi hass[14964]: INFO:homeassistant.components.http:"POST /api/services/homeassistant/turn_off HTTP/1.1" 200 -
Feb 10 02:53:15 raspberrypi hass[14964]: INFO:homeassistant.components.mysensors:update sensor_update: node 3
Feb 10 02:53:15 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.0: value_type 2, value = 0
Feb 10 02:53:15 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.0: value_type 3, value = 100
Feb 10 02:53:15 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.1: value_type 2, value = 1
Feb 10 02:53:15 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.1: value_type 3, value = 100
Feb 10 02:53:15 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.2: value_type 2, value = 1
Feb 10 02:53:15 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.2: value_type 3, value = 100
Feb 10 02:53:15 raspberrypi hass[14964]: INFO:homeassistant.components.mysensors:update sensor_update: node 3
Feb 10 02:53:15 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.0: value_type 2, value = 0
Feb 10 02:53:15 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.0: value_type 3, value = 0
Feb 10 02:53:15 raspberrypi hass[14964]: INFO:homeassistant.core:Bus:Handling <Event state_changed[L]: old_state=<state switch.holidayleddesklights_30=off; node_id=3, V_PERCENTAGE=100, child_id=0, friendly_name=HolidayLEDDeskLights 3.0, battery_level=0, port=/dev/ttyUSB0 @ 22:53:14 09-02-2016>, new_state=<state switch.holidayleddesklights_30=off; node_id=3, V_PERCENTAGE=0, child_id=0, friendly_name=HolidayLEDDeskLights 3.0, battery_level=0, port=/dev/ttyUSB0 @ 22:53:14 09-02-2016>, entity_id=switch.holidayleddesklights_30>
Feb 10 02:53:15 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.1: value_type 2, value = 1
Feb 10 02:53:15 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.1: value_type 3, value = 100
Feb 10 02:53:15 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.2: value_type 2, value = 1
Feb 10 02:53:15 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.2: value_type 3, value = 100
Feb 10 02:53:16 raspberrypi hass[14964]: INFO:homeassistant.components.mysensors:update sensor_update: node 3
Feb 10 02:53:16 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.0: value_type 2, value = 0
Feb 10 02:53:16 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.0: value_type 3, value = 0
Feb 10 02:53:16 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.1: value_type 2, value = 0
Feb 10 02:53:16 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.1: value_type 3, value = 100
Feb 10 02:53:16 raspberrypi hass[14964]: INFO:homeassistant.core:Bus:Handling <Event state_changed[L]: old_state=<state switch.holidayleddesklights_31=on; node_id=3, V_PERCENTAGE=100, child_id=1, friendly_name=HolidayLEDDeskLights 3.1, battery_level=0, port=/dev/ttyUSB0 @ 22:53:03 09-02-2016>, new_state=<state switch.holidayleddesklights_31=off; node_id=3, V_PERCENTAGE=100, child_id=1, friendly_name=HolidayLEDDeskLights 3.1, battery_level=0, port=/dev/ttyUSB0 @ 22:53:16 09-02-2016>, entity_id=switch.holidayleddesklights_31>
Feb 10 02:53:16 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.2: value_type 2, value = 1
Feb 10 02:53:16 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.2: value_type 3, value = 100
Feb 10 02:53:16 raspberrypi hass[14964]: INFO:homeassistant.components.mysensors:update sensor_update: node 3
Feb 10 02:53:16 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.0: value_type 2, value = 0
Feb 10 02:53:16 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.0: value_type 3, value = 0
Feb 10 02:53:16 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.1: value_type 2, value = 0
Feb 10 02:53:16 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.1: value_type 3, value = 0
Feb 10 02:53:16 raspberrypi hass[14964]: INFO:homeassistant.core:Bus:Handling <Event state_changed[L]: old_state=<state switch.holidayleddesklights_31=off; node_id=3, V_PERCENTAGE=100, child_id=1, friendly_name=HolidayLEDDeskLights 3.1, battery_level=0, port=/dev/ttyUSB0 @ 22:53:16 09-02-2016>, new_state=<state switch.holidayleddesklights_31=off; node_id=3, V_PERCENTAGE=0, child_id=1, friendly_name=HolidayLEDDeskLights 3.1, battery_level=0, port=/dev/ttyUSB0 @ 22:53:16 09-02-2016>, entity_id=switch.holidayleddesklights_31>
Feb 10 02:53:16 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.2: value_type 2, value = 1
Feb 10 02:53:16 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.2: value_type 3, value = 100
Feb 10 02:53:17 raspberrypi hass[14964]: INFO:homeassistant.components.mysensors:update sensor_update: node 3
Feb 10 02:53:17 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.0: value_type 2, value = 0
Feb 10 02:53:17 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.0: value_type 3, value = 0
Feb 10 02:53:17 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.1: value_type 2, value = 0
Feb 10 02:53:17 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.1: value_type 3, value = 0
Feb 10 02:53:17 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.2: value_type 2, value = 0
Feb 10 02:53:17 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.2: value_type 3, value = 100
Feb 10 02:53:17 raspberrypi hass[14964]: INFO:homeassistant.core:Bus:Handling <Event state_changed[L]: old_state=<state switch.holidayleddesklights_32=on; node_id=3, V_PERCENTAGE=100, child_id=2, friendly_name=HolidayLEDDeskLights 3.2, battery_level=0, port=/dev/ttyUSB0 @ 22:53:04 09-02-2016>, new_state=<state switch.holidayleddesklights_32=off; node_id=3, V_PERCENTAGE=100, child_id=2, friendly_name=HolidayLEDDeskLights 3.2, battery_level=0, port=/dev/ttyUSB0 @ 22:53:17 09-02-2016>, entity_id=switch.holidayleddesklights_32>
Feb 10 02:53:17 raspberrypi hass[14964]: INFO:homeassistant.components.mysensors:update sensor_update: node 3
Feb 10 02:53:17 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.0: value_type 2, value = 0
Feb 10 02:53:17 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.0: value_type 3, value = 0
Feb 10 02:53:17 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.1: value_type 2, value = 0
Feb 10 02:53:17 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.1: value_type 3, value = 0
Feb 10 02:53:17 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.2: value_type 2, value = 0
Feb 10 02:53:17 raspberrypi hass[14964]: INFO:homeassistant.components.switch.mysensors:HolidayLEDDeskLights 3.2: value_type 3, value = 0
Feb 10 02:53:17 raspberrypi hass[14964]: INFO:homeassistant.core:Bus:Handling <Event state_changed[L]: old_state=<state switch.holidayleddesklights_32=off; node_id=3, V_PERCENTAGE=100, child_id=2, friendly_name=HolidayLEDDeskLights 3.2, battery_level=0, port=/dev/ttyUSB0 @ 22:53:17 09-02-2016>, new_state=<state switch.holidayleddesklights_32=off; node_id=3, V_PERCENTAGE=0, child_id=2, friendly_name=HolidayLEDDeskLights 3.2, battery_level=0, port=/dev/ttyUSB0 @ 22:53:17 09-02-2016>, entity_id=switch.holidayleddesklights_32>
Feb 10 02:53:20 raspberrypi hass[14964]: INFO:homeassistant.components.media_player:Updating media_player entities
Feb 10 02:53:28 raspberrypi hass[14964]: INFO:homeassistant.components.mysensors:update sensor_update: node 9
Feb 10 02:53:28 raspberrypi hass[14964]: INFO:homeassistant.components.mysensors:No sketch_name: node 9
Feb 10 02:53:29 raspberrypi hass[14964]: INFO:homeassistant.components.mysensors:No sketch_name: node 9
Feb 10 02:53:30 raspberrypi hass[14964]: INFO:homeassistant.components.media_player:Updating media_player entities
Feb 10 02:53:30 raspberrypi hass[14964]: INFO:homeassistant.components.light:Updating light entities
Feb 10 02:53:30 raspberrypi hass[14964]: INFO:homeassistant.components.camera:Updating camera entities
Feb 10 02:53:30 raspberrypi hass[14964]: INFO:homeassistant.core:Bus:Handling <Event state_changed[L]: old_state=<state camera.livingroom_cam=idle; friendly_name=LivingRoom Cam, entity_picture=/api/camera_proxy/camera.livingroom_cam?time=1455072780.5222528 @ 22:50:02 09-02-2016>, new_state=<state camera.livingroom_cam=idle; friendly_name=LivingRoom Cam, entity_picture=/api/camera_proxy/camera.livingroom_cam?time=1455072810.5219505 @ 22:50:02 09-02-2016>, entity_id=camera.livingroom_cam>
Feb 10 02:53:30 raspberrypi hass[14964]: INFO:homeassistant.core:Bus:Handling <Event state_changed[L]: old_state=<state sun.sun=below_horizon; next_setting=21:39:26 10-02-2016, next_rising=11:25:09 10-02-2016, friendly_name=Sun, elevation=-53.42 @ 22:50:02 09-02-2016>, new_state=<state sun.sun=below_horizon; next_setting=21:39:26 10-02-2016, next_rising=11:25:09 10-02-2016, friendly_name=Sun, elevation=-53.54 @ 22:50:02 09-02-2016>, entity_id=sun.sun>
Feb 10 02:53:30 raspberrypi hass[14964]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.117
Feb 10 02:53:40 raspberrypi hass[14964]: Exception in thread Thread-5:
Feb 10 02:53:40 raspberrypi hass[14964]: Traceback (most recent call last):
Feb 10 02:53:40 raspberrypi hass[14964]: File "/usr/lib/python3.4/threading.py", line 920, in _bootstrap_inner
Feb 10 02:53:40 raspberrypi hass[14964]: self.run()
Feb 10 02:53:40 raspberrypi hass[14964]: File "/home/pi/.homeassistant/lib/mysensors/mysensors.py", line 312, in run
Feb 10 02:53:40 raspberrypi hass[14964]: response = self.handle_queue()
Feb 10 02:53:40 raspberrypi hass[14964]: File "/home/pi/.homeassistant/lib/mysensors/mysensors.py", line 222, in handle_queue
Feb 10 02:53:40 raspberrypi hass[14964]: reply = func(*args, **kwargs)
Feb 10 02:53:40 raspberrypi hass[14964]: File "/home/pi/.homeassistant/lib/mysensors/mysensors.py", line 105, in logic
Feb 10 02:53:40 raspberrypi hass[14964]: msg = Message(data)
Feb 10 02:53:40 raspberrypi hass[14964]: File "/home/pi/.homeassistant/lib/mysensors/mysensors.py", line 397, in __init__
Feb 10 02:53:40 raspberrypi hass[14964]: self.decode(data)
Feb 10 02:53:40 raspberrypi hass[14964]: File "/home/pi/.homeassistant/lib/mysensors/mysensors.py", line 417, in decode
Feb 10 02:53:40 raspberrypi hass[14964]: self.sub_type) = [int(f) for f in data]
Feb 10 02:53:40 raspberrypi hass[14964]: ValueError: need more than 0 values to unpack
Feb 10 02:53:40 raspberrypi hass[14964]: INFO:homeassistant.components.media_player:Updating media_player entities
Feb 10 02:53:50 raspberrypi hass[14964]: INFO:homeassistant.components.media_player:Updating media_player entities
Feb 10 02:54:00 raspberrypi hass[14964]: INFO:homeassistant.components.media_player:Updating media_player entities
Feb 10 02:54:00 raspberrypi hass[14964]: INFO:homeassistant.components.light:Updating light entities
Feb 10 02:54:00 raspberrypi hass[14964]: INFO:homeassistant.components.camera:Updating camera entities
Feb 10 02:54:00 raspberrypi hass[14964]: INFO:homeassistant.core:Bus:Handling <Event state_changed[L]: old_state=<state camera.livingroom_cam=idle; friendly_name=LivingRoom Cam, entity_picture=/api/camera_proxy/camera.livingroom_cam?time=1455072810.5219505 @ 22:50:02 09-02-2016>, new_state=<state camera.livingroom_cam=idle; friendly_name=LivingRoom Cam, entity_picture=/api/camera_proxy/camera.livingroom_cam?time=1455072840.5167649 @ 22:50:02 09-02-2016>, entity_id=camera.livingroom_cam>

And the Scene Controller itself seems to be presenting itself correctly, even to the point that Home-Assistant the first time assigned it a Node ID of 9, just no response on the gateway end.

send: 9-9-0-0 s=255,c=0,t=17,pt=0,l=5,sg=0,st=ok:1.5.1
send: 9-9-0-0 s=255,c=3,t=6,pt=1,l=1,sg=0,st=ok:0
sensor started, id=9, parent=0, distance=1
send: 9-9-0-0 s=255,c=3,t=11,pt=0,l=16,sg=0,st=ok:Scene Controller
send: 9-9-0-0 s=255,c=3,t=12,pt=0,l=3,sg=0,st=ok:1.0
send: 9-9-0-0 s=0,c=0,t=25,pt=0,l=0,sg=0,st=ok:
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:1
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:2
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:3
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:4
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:5
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:6
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:7
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:8
send: 9-9-0-0 s=0,c=1,t=19,pt=2,l=2,sg=0,st=ok:9

[martinhjelmare]

@drock1985

You get an error in the log, due to not complete message received via serial. Since this is not caught, the thread will hang. This is fixed in the dev branch at pymysensors, but we haven't included it in home assistant yet. I hope to do that for the next release.

It would help if you activate debug for the mysensors component in the config for home assistant, so we can pinpoint exactly which message gives the error.

[drock1985]

@martinhjelmare

pi@raspberrypi:~/.homeassistant $ sudo service home-assistant restart
pi@raspberrypi:~/.homeassistant $ clear
pi@raspberrypi:~/.homeassistant $ sudo journalctl -f -u home-assistant
-- Logs begin at Tue 2016-02-09 13:21:39 UTC. --
Feb 11 11:35:37 raspberrypi hass[20996]: INFO:homeassistant.core:Bus:Handling <Event state_changed[L]: new_state=<state sensor.motion_sensor_81=; friendly_name=Motion Sensor 8.1, node_id=8, port=/dev/ttyUSB0, child_id=1, battery_level=0 @ 07:35:37 11-02-2016>, entity_id=sensor.motion_sensor_81>
Feb 11 11:35:37 raspberrypi hass[20996]: INFO:homeassistant.components.sensor.mysensors:Motion Sensor 8.1: value_type 16, value = 0
Feb 11 11:35:37 raspberrypi hass[20996]: INFO:homeassistant.core:Bus:Handling <Event state_changed[L]: old_state=<state sensor.motion_sensor_81=; friendly_name=Motion Sensor 8.1, node_id=8, port=/dev/ttyUSB0, child_id=1, battery_level=0 @ 07:35:37 11-02-2016>, new_state=<state sensor.motion_sensor_81=off; friendly_name=Motion Sensor 8.1, node_id=8, port=/dev/ttyUSB0, child_id=1, battery_level=0 @ 07:35:37 11-02-2016>, entity_id=sensor.motion_sensor_81>
Feb 11 11:35:37 raspberrypi hass[20996]: INFO:homeassistant.components.mysensors:update persistence: node 9
Feb 11 11:35:37 raspberrypi hass[20996]: INFO:homeassistant.components.mysensors:No sketch_name: node 9
Feb 11 11:35:37 raspberrypi hass[20996]: INFO:homeassistant.components.mysensors:No sketch_name: node 9
Feb 11 11:35:37 raspberrypi hass[20996]: INFO:homeassistant.components.mysensors:update persistence: node 10
Feb 11 11:35:40 raspberrypi hass[20996]: INFO:mysensors.mysensors:/dev/ttyUSB0 is open...
Feb 11 11:35:40 raspberrypi hass[20996]: INFO:mysensors.mysensors:Connected to /dev/ttyUSB0
Feb 11 11:35:40 raspberrypi hass[20996]: INFO:mysensors.mysensors:n:0 c:0 t:3 s:9 p:gateway started, id=0, parent=0, distance=0
Feb 11 11:35:40 raspberrypi hass[20996]: INFO:homeassistant.components.media_player:Updating media_player entities
Feb 11 11:35:49 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.101
Feb 11 11:35:49 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.1
Feb 11 11:35:49 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.100
Feb 11 11:35:49 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.199
Feb 11 11:35:49 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.113
Feb 11 11:35:49 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.113
Feb 11 11:35:49 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.4
Feb 11 11:35:49 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.108
Feb 11 11:35:49 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.163
Feb 11 11:35:49 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.111
Feb 11 11:35:50 raspberrypi hass[20996]: INFO:homeassistant.components.media_player:Updating media_player entities
Feb 11 11:35:51 raspberrypi hass[20996]: INFO:homeassistant.components.discovery:Found new service: philips_hue ('Philips hue (192.168.86.199)', 'http://192.168.86.199:80/')
Feb 11 11:35:51 raspberrypi hass[20996]: INFO:homeassistant.loader:Loaded light from homeassistant.components.light
Feb 11 11:35:51 raspberrypi hass[20996]: INFO:homeassistant.core:Bus:Handling <Event service_registered[L]: domain=light, service=turn_on>
Feb 11 11:35:51 raspberrypi hass[20996]: INFO:homeassistant.core:Bus:Handling <Event service_registered[L]: domain=light, service=turn_off>
Feb 11 11:35:51 raspberrypi hass[20996]: INFO:homeassistant.core:Bus:Handling <Event service_registered[L]: domain=light, service=toggle>
Feb 11 11:35:51 raspberrypi hass[20996]: INFO:homeassistant.core:Bus:Handling <Event component_loaded[L]: component=light>
Feb 11 11:35:51 raspberrypi hass[20996]: INFO:homeassistant.core:Bus:Handling <Event platform_discovered[L]: discovered=('Philips hue (192.168.86.199)', 'http://192.168.86.199:80/'), service=philips_hue>
Feb 11 11:35:51 raspberrypi hass[20996]: INFO:homeassistant.loader:Loaded light.hue from homeassistant.components.light.hue
Feb 11 11:35:51 raspberrypi hass[20996]: INFO:phue:Attempting to connect to the bridge...
Feb 11 11:35:51 raspberrypi hass[20996]: INFO:phue:Using ip: 192.168.86.199
Feb 11 11:35:51 raspberrypi hass[20996]: INFO:phue:Using username from config: 17de782878661df2bf4edd823bafdcf
Feb 11 11:35:51 raspberrypi hass[20996]: INFO:homeassistant.core:Bus:Handling <Event state_changed[L]: new_state=<state light.living_room_light_1=off; friendly_name=Living room light 1 @ 07:35:51 11-02-2016>, entity_id=light.living_room_light_1>
Feb 11 11:35:51 raspberrypi hass[20996]: INFO:homeassistant.core:Bus:Handling <Event state_changed[L]: new_state=<state light.living_room_light_2=off; friendly_name=Living room light 2 @ 07:35:51 11-02-2016>, entity_id=light.living_room_light_2>
Feb 11 11:35:51 raspberrypi hass[20996]: INFO:homeassistant.core:Bus:Handling <Event state_changed[L]: new_state=<state light.master_bedroom_1=off; friendly_name=Master bedroom 1 @ 07:35:51 11-02-2016>, entity_id=light.master_bedroom_1>
Feb 11 11:35:51 raspberrypi hass[20996]: INFO:homeassistant.core:Bus:Handling <Event state_changed[L]: new_state=<state light.master_bedroom_light_strip=off; friendly_name=Master bedroom light strip @ 07:35:51 11-02-2016>, entity_id=light.master_bedroom_light_strip>
Feb 11 11:35:51 raspberrypi hass[20996]: INFO:homeassistant.core:Bus:Handling <Event state_changed[L]: new_state=<state light.aprils_lamp=off; friendly_name=April's lamp @ 07:35:51 11-02-2016>, entity_id=light.aprils_lamp>
Feb 11 11:35:51 raspberrypi hass[20996]: INFO:homeassistant.core:Bus:Handling <Event state_changed[L]: new_state=<state light.master_bedroom_2=off; friendly_name=Master bedroom 2 @ 07:35:51 11-02-2016>, entity_id=light.master_bedroom_2>
Feb 11 11:35:51 raspberrypi hass[20996]: INFO:homeassistant.core:Bus:Handling <Event state_changed[L]: new_state=<state light.master_bedroom_3=off; friendly_name=Master bedroom 3 @ 07:35:51 11-02-2016>, entity_id=light.master_bedroom_3>
Feb 11 11:35:51 raspberrypi hass[20996]: INFO:homeassistant.core:Bus:Handling <Event state_changed[L]: new_state=<state group.all_lights=unknown; hidden=True, friendly_name=all lights, entity_id=[], auto=True, order=1 @ 07:35:51 11-02-2016>, entity_id=group.all_lights>
Feb 11 11:35:51 raspberrypi hass[20996]: INFO:homeassistant.core:Bus:Handling <Event state_changed[L]: new_state=<state group.all_lights=off; hidden=True, friendly_name=all lights, entity_id=('light.master_bedroom_3', 'light.living_room_light_1', 'light.aprils_lamp', 'light.master_bedroom_light_strip', 'light.living_room_light_2', 'light.master_bedroom_1', 'light.master_bedroom_2'), auto=True, order=1 @ 07:35:51 11-02-2016>, entity_id=group.all_lights>
Feb 11 11:35:52 raspberrypi hass[20996]: INFO:homeassistant.components.discovery:Found new service: plex_mediaserver ('Rocknet Server', 'https://192.168.86.4:32400')
Feb 11 11:35:52 raspberrypi hass[20996]: INFO:homeassistant.core:Bus:Handling <Event platform_discovered[L]: discovered=('Rocknet Server', 'https://192.168.86.4:32400'), service=plex_mediaserver>
Feb 11 11:35:52 raspberrypi hass[20996]: INFO:homeassistant.components.discovery:Found new service: DLNA http://192.168.86.4:32469/DeviceDescription.xml
Feb 11 11:35:52 raspberrypi hass[20996]: INFO:homeassistant.components.discovery:Found new service: DLNA http://192.168.86.113:9000/plugins/UPnP/MediaServer.xml
Feb 11 11:35:52 raspberrypi hass[20996]: INFO:homeassistant.components.discovery:Found new service: belkin_wemo ('LivingRoomLamp', 'Socket', 'http://192.168.86.163:49153/setup.xml', '94103E30C688')
Feb 11 11:35:52 raspberrypi hass[20996]: INFO:homeassistant.core:Bus:Handling <Event platform_discovered[L]: discovered=('LivingRoomLamp', 'Socket', 'http://192.168.86.163:49153/setup.xml', '94103E30C688'), service=belkin_wemo>
Feb 11 11:35:52 raspberrypi hass[20996]: INFO:homeassistant.components.discovery:Found new service: belkin_wemo ('Christmas Tree Lights', 'Insight', 'http://192.168.86.111:49153/setup.xml', '94103E395F2C')
Feb 11 11:35:52 raspberrypi hass[20996]: INFO:homeassistant.loader:Loaded media_player.plex from homeassistant.components.media_player.plex
Feb 11 11:35:52 raspberrypi hass[20996]: INFO:homeassistant.core:Bus:Handling <Event platform_discovered[L]: discovered=('Christmas Tree Lights', 'Insight', 'http://192.168.86.111:49153/setup.xml', '94103E395F2C'), service=belkin_wemo>
Feb 11 11:35:52 raspberrypi hass[20996]: INFO:homeassistant.loader:Loaded switch.wemo from homeassistant.components.switch.wemo
Feb 11 11:35:52 raspberrypi hass[20996]: INFO:homeassistant.components.discovery:Found new service: belkin_wemo ('CatFan', 'Socket', 'http://192.168.86.108:49153/setup.xml', '94103E30CDBC')
Feb 11 11:35:52 raspberrypi hass[20996]: INFO:homeassistant.loader:Loaded switch.wemo from homeassistant.components.switch.wemo
Feb 11 11:35:52 raspberrypi hass[20996]: INFO:homeassistant.core:Bus:Handling <Event platform_discovered[L]: discovered=('CatFan', 'Socket', 'http://192.168.86.108:49153/setup.xml', '94103E30CDBC'), service=belkin_wemo>
Feb 11 11:35:52 raspberrypi hass[20996]: INFO:homeassistant.components.discovery:Found new service: google_cast ('192.168.86.100', 8009)
Feb 11 11:35:52 raspberrypi hass[20996]: INFO:homeassistant.core:Bus:Handling <Event platform_discovered[L]: discovered=('192.168.86.100', 8009), service=google_cast>
Feb 11 11:35:52 raspberrypi hass[20996]: INFO:homeassistant.components.discovery:Found new service: google_cast ('192.168.86.101', 8009)
Feb 11 11:35:52 raspberrypi hass[20996]: INFO:homeassistant.core:Bus:Handling <Event platform_discovered[L]: discovered=('192.168.86.101', 8009), service=google_cast>
Feb 11 11:35:52 raspberrypi hass[20996]: INFO:homeassistant.loader:Loaded media_player.cast from homeassistant.components.media_player.cast
Feb 11 11:35:52 raspberrypi hass[20996]: INFO:homeassistant.loader:Loaded media_player.cast from homeassistant.components.media_player.cast
Feb 11 11:35:52 raspberrypi hass[20996]: INFO:plexapi:GET http://192.168.86.4:32400/
Feb 11 11:35:52 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.4
Feb 11 11:35:52 raspberrypi hass[20996]: INFO:homeassistant.components.media_player.plex:Connected to: http://192.168.86.4:32400
Feb 11 11:35:52 raspberrypi hass[20996]: INFO:plexapi:GET http://192.168.86.4:32400/clients
Feb 11 11:35:52 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.4
Feb 11 11:35:52 raspberrypi hass[20996]: INFO:pywemo.subscribe:Listening on port 8989
Feb 11 11:35:52 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.111
Feb 11 11:35:52 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.163
Feb 11 11:35:52 raspberrypi hass[20996]: INFO:plexapi:GET http://192.168.86.4:32400/status/sessions
Feb 11 11:35:52 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.108
Feb 11 11:35:52 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.4
Feb 11 11:35:52 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.108
Feb 11 11:35:52 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.163
Feb 11 11:35:52 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.111
Feb 11 11:35:52 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.108
Feb 11 11:35:52 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.163
Feb 11 11:35:52 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.111
Feb 11 11:35:52 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.108
Feb 11 11:35:52 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.163
Feb 11 11:35:53 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.111
Feb 11 11:35:53 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.163
Feb 11 11:35:53 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.108
Feb 11 11:35:53 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.111
Feb 11 11:35:53 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.163
Feb 11 11:35:53 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.163
Feb 11 11:35:53 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.108
Feb 11 11:35:53 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.111
Feb 11 11:35:53 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.108
Feb 11 11:35:53 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.111
Feb 11 11:35:53 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.163
Feb 11 11:35:53 raspberrypi hass[20996]: ERROR:homeassistant.components.media_player:Error while setting up platform cast
Feb 11 11:35:53 raspberrypi hass[20996]: Traceback (most recent call last):
Feb 11 11:35:53 raspberrypi hass[20996]: File "/usr/local/lib/python3.4/dist-packages/homeassistant/helpers/entity_component.py", line 146, in _setup_platform
Feb 11 11:35:53 raspberrypi hass[20996]: self.hass, platform_config, self.add_entities, discovery_info)
Feb 11 11:35:53 raspberrypi hass[20996]: File "/usr/local/lib/python3.4/dist-packages/homeassistant/components/media_player/cast.py", line 39, in setup_platform
Feb 11 11:35:53 raspberrypi hass[20996]: import pychromecast
Feb 11 11:35:53 raspberrypi hass[20996]: File "/home/pi/.homeassistant/lib/pychromecast/__init__.py", line 14, in <module>
Feb 11 11:35:53 raspberrypi hass[20996]: from . import socket_client
Feb 11 11:35:53 raspberrypi hass[20996]: ImportError: cannot import name 'socket_client'
Feb 11 11:35:53 raspberrypi hass[20996]: ERROR:homeassistant.components.media_player:Error while setting up platform cast
Feb 11 11:35:53 raspberrypi hass[20996]: Traceback (most recent call last):
Feb 11 11:35:53 raspberrypi hass[20996]: File "/usr/local/lib/python3.4/dist-packages/homeassistant/helpers/entity_component.py", line 146, in _setup_platform
Feb 11 11:35:53 raspberrypi hass[20996]: self.hass, platform_config, self.add_entities, discovery_info)
Feb 11 11:35:53 raspberrypi hass[20996]: File "/usr/local/lib/python3.4/dist-packages/homeassistant/components/media_player/cast.py", line 68, in setup_platform
Feb 11 11:35:53 raspberrypi hass[20996]: casts.append(CastDevice(host))
Feb 11 11:35:53 raspberrypi hass[20996]: File "/usr/local/lib/python3.4/dist-packages/homeassistant/components/media_player/cast.py", line 84, in __init__
Feb 11 11:35:53 raspberrypi hass[20996]: import pychromecast.controllers.youtube as youtube
Feb 11 11:35:53 raspberrypi hass[20996]: AttributeError: 'module' object has no attribute 'controllers'
Feb 11 11:35:53 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.108
Feb 11 11:35:53 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.111
Feb 11 11:35:53 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.163
Feb 11 11:35:53 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.108
Feb 11 11:35:53 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.111
Feb 11 11:35:53 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.163
Feb 11 11:35:53 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.111
Feb 11 11:35:53 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.108
Feb 11 11:35:53 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.163
Feb 11 11:35:53 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.163
Feb 11 11:35:53 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.108
Feb 11 11:35:53 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.111
Feb 11 11:35:53 raspberrypi hass[20996]: INFO:pywemo.subscribe:Subscribing to events from <WeMo Switch "LivingRoomLamp">
Feb 11 11:35:53 raspberrypi hass[20996]: INFO:pywemo.subscribe:Resubscribe for <WeMo Switch "LivingRoomLamp">
Feb 11 11:35:53 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.163
Feb 11 11:35:53 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.163
Feb 11 11:35:53 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.108
Feb 11 11:35:53 raspberrypi hass[20996]: INFO:homeassistant.core:Bus:Handling <Event state_changed[L]: new_state=<state switch.livingroomlamp=on; friendly_name=LivingRoomLamp @ 07:35:53 11-02-2016>, entity_id=switch.livingroomlamp>
Feb 11 11:35:53 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.111
Feb 11 11:35:53 raspberrypi hass[20996]: INFO:homeassistant.core:Bus:Handling <Event state_changed[L]: new_state=<state group.all_switches=on; hidden=True, friendly_name=all switches, entity_id=('switch.man_cave_lamp_41', 'switch.holidayleddesklights_31', 'switch.holidayleddesklights_32', 'switch.2_door_bellchime_monitor_21', 'switch.holidayleddesklights_30', 'switch.2_door_bellchime_monitor_23', 'switch.livingroomlamp'), auto=True, order=0 @ 07:35:53 11-02-2016>, entity_id=group.all_switches>
Feb 11 11:35:53 raspberrypi hass[20996]: INFO:pywemo.subscribe:Received event from <WeMo Switch "LivingRoomLamp">(192.168.86.163)
Feb 11 11:35:53 raspberrypi hass[20996]: INFO:pywemo.subscribe:Subscribing to events from <WeMo Switch "CatFan">
Feb 11 11:35:53 raspberrypi hass[20996]: INFO:homeassistant.components.switch.wemo:Subscription update for  <WeMo Switch "LivingRoomLamp">
Feb 11 11:35:54 raspberrypi hass[20996]: INFO:pywemo.subscribe:Resubscribe for <WeMo Switch "CatFan">
Feb 11 11:35:54 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.108
Feb 11 11:35:54 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.111
Feb 11 11:35:54 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.163
Feb 11 11:35:54 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.108
Feb 11 11:35:54 raspberrypi hass[20996]: INFO:homeassistant.core:Bus:Handling <Event state_changed[L]: new_state=<state switch.catfan=off; friendly_name=CatFan @ 07:35:54 11-02-2016>, entity_id=switch.catfan>
Feb 11 11:35:54 raspberrypi hass[20996]: INFO:homeassistant.core:Bus:Handling <Event state_changed[L]: new_state=<state group.all_switches=on; hidden=True, friendly_name=all switches, entity_id=('switch.man_cave_lamp_41', 'switch.holidayleddesklights_31', 'switch.catfan', 'switch.holidayleddesklights_32', 'switch.2_door_bellchime_monitor_21', 'switch.holidayleddesklights_30', 'switch.2_door_bellchime_monitor_23', 'switch.livingroomlamp'), auto=True, order=0 @ 07:35:54 11-02-2016>, entity_id=group.all_switches>
Feb 11 11:35:54 raspberrypi hass[20996]: INFO:pywemo.subscribe:Subscribing to events from <WeMo Insight "Christmas Tree Lights">
Feb 11 11:35:54 raspberrypi hass[20996]: INFO:pywemo.subscribe:Received event from <WeMo Switch "CatFan">(192.168.86.108)
Feb 11 11:35:54 raspberrypi hass[20996]: INFO:homeassistant.components.switch.wemo:Subscription update for  <WeMo Switch "CatFan">
Feb 11 11:35:54 raspberrypi hass[20996]: INFO:pywemo.subscribe:Resubscribe for <WeMo Insight "Christmas Tree Lights">
Feb 11 11:35:54 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.108
Feb 11 11:35:54 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.111
Feb 11 11:35:54 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.111
Feb 11 11:35:54 raspberrypi hass[20996]: INFO:homeassistant.core:Bus:Handling <Event state_changed[L]: new_state=<state switch.christmas_tree_lights=off; friendly_name=Christmas Tree Lights @ 07:35:54 11-02-2016>, entity_id=switch.christmas_tree_lights>
Feb 11 11:35:54 raspberrypi hass[20996]: INFO:homeassistant.core:Bus:Handling <Event state_changed[L]: new_state=<state group.all_switches=on; hidden=True, friendly_name=all switches, entity_id=('switch.man_cave_lamp_41', 'switch.holidayleddesklights_31', 'switch.catfan', 'switch.holidayleddesklights_32', 'switch.2_door_bellchime_monitor_21', 'switch.christmas_tree_lights', 'switch.holidayleddesklights_30', 'switch.2_door_bellchime_monitor_23', 'switch.livingroomlamp'), auto=True, order=0 @ 07:35:54 11-02-2016>, entity_id=group.all_switches>
Feb 11 11:35:54 raspberrypi hass[20996]: INFO:pywemo.subscribe:Received event from <WeMo Insight "Christmas Tree Lights">(192.168.86.111)
Feb 11 11:35:54 raspberrypi hass[20996]: INFO:homeassistant.components.switch.wemo:Subscription update for  <WeMo Insight "Christmas Tree Lights">
Feb 11 11:35:54 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.111
Feb 11 11:35:54 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.111
Feb 11 11:35:54 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.111
Feb 11 11:35:55 raspberrypi hass[20996]: INFO:pywemo.subscribe:Received event from <WeMo Insight "Christmas Tree Lights">(192.168.86.111)
Feb 11 11:35:55 raspberrypi hass[20996]: INFO:homeassistant.components.switch.wemo:Subscription update for  <WeMo Insight "Christmas Tree Lights">
Feb 11 11:35:55 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.111
Feb 11 11:35:55 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.111
Feb 11 11:35:55 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.111
Feb 11 11:35:57 raspberrypi hass[20996]: INFO:mysensors.mysensors:n:0 c:0 t:3 s:9 p:read: 9-9-0 s=255,c=0,t=17,pt=0,l=5,sg=0:1.5.1
Feb 11 11:35:57 raspberrypi hass[20996]: INFO:homeassistant.components.mysensors:update sensor_update: node 9
Feb 11 11:35:57 raspberrypi hass[20996]: INFO:homeassistant.components.mysensors:No sketch_name: node 9
Feb 11 11:35:57 raspberrypi hass[20996]: INFO:homeassistant.components.mysensors:No sketch_name: node 9
Feb 11 11:35:57 raspberrypi hass[20996]: INFO:mysensors.mysensors:n:0 c:0 t:3 s:9 p:read: 9-9-0 s=255,c=3,t=6,pt=1,l=1,sg=0:0
Feb 11 11:35:57 raspberrypi hass[20996]: INFO:mysensors.mysensors:n:0 c:0 t:3 s:9 p:send: 0-0-9-9 s=255,c=3,t=6,pt=0,l=1,sg=0,st=ok:M
Feb 11 11:35:59 raspberrypi hass[20996]: INFO:mysensors.mysensors:n:0 c:0 t:3 s:9 p:read: 9-9-0 s=255,c=3,t=11,pt=0,l=16,sg=0:Scene Controller
Feb 11 11:36:00 raspberrypi hass[20996]: Exception in thread Thread-9:
Feb 11 11:36:00 raspberrypi hass[20996]: Traceback (most recent call last):
Feb 11 11:36:00 raspberrypi hass[20996]: File "/usr/lib/python3.4/threading.py", line 920, in _bootstrap_inner
Feb 11 11:36:00 raspberrypi hass[20996]: self.run()
Feb 11 11:36:00 raspberrypi hass[20996]: File "/home/pi/.homeassistant/lib/mysensors/mysensors.py", line 312, in run
Feb 11 11:36:00 raspberrypi hass[20996]: response = self.handle_queue()
Feb 11 11:36:00 raspberrypi hass[20996]: File "/home/pi/.homeassistant/lib/mysensors/mysensors.py", line 222, in handle_queue
Feb 11 11:36:00 raspberrypi hass[20996]: reply = func(*args, **kwargs)
Feb 11 11:36:00 raspberrypi hass[20996]: File "/home/pi/.homeassistant/lib/mysensors/mysensors.py", line 105, in logic
Feb 11 11:36:00 raspberrypi hass[20996]: msg = Message(data)
Feb 11 11:36:00 raspberrypi hass[20996]: File "/home/pi/.homeassistant/lib/mysensors/mysensors.py", line 397, in __init__
Feb 11 11:36:00 raspberrypi hass[20996]: self.decode(data)
Feb 11 11:36:00 raspberrypi hass[20996]: File "/home/pi/.homeassistant/lib/mysensors/mysensors.py", line 417, in decode
Feb 11 11:36:00 raspberrypi hass[20996]: self.sub_type) = [int(f) for f in data]
Feb 11 11:36:00 raspberrypi hass[20996]: ValueError: need more than 0 values to unpack
Feb 11 11:36:00 raspberrypi hass[20996]: INFO:homeassistant.components.media_player:Updating media_player entities
Feb 11 11:36:00 raspberrypi hass[20996]: INFO:homeassistant.components.light:Updating light entities
Feb 11 11:36:00 raspberrypi hass[20996]: INFO:homeassistant.components.camera:Updating camera entities
Feb 11 11:36:00 raspberrypi hass[20996]: INFO:homeassistant.core:Bus:Handling <Event state_changed[L]: old_state=<state camera.livingroom_cam=idle; entity_picture=/api/camera_proxy/camera.livingroom_cam?time=1455190535.9862137, friendly_name=LivingRoom Cam @ 07:35:35 11-02-2016>, new_state=<state camera.livingroom_cam=idle; entity_picture=/api/camera_proxy/camera.livingroom_cam?time=1455190560.5117981, friendly_name=LivingRoom Cam @ 07:35:35 11-02-2016>, entity_id=camera.livingroom_cam>
Feb 11 11:36:00 raspberrypi hass[20996]: INFO:urllib3.connectionpool:Starting new HTTP connection (1): 192.168.86.117

[martinhjelmare]

@drock1985

Thanks. Ok, it seems it fails on the message after receiving the sketch name. That should be the sketch version. It's more probable that the sketch name is causing troubles though, I think. Try using a shorter one-word name.

[drock1985]

@martinhjelmare

Good call, it was the name. Changed it to SC and it showed up fine. Now to link this to switches and scenes.

Thanks!

[martinhjelmare]

@drock1985

:thumbsup: