Without me doing anzthing particular besides upgrading to version 81 the door sensor does no longer report to HA.
I tried deleting it adding it back as secure node but none of this has an effect.
Any ideas?
Any ideas?
Not much to go on here …
Well that gets us started, there are many more potential factors that might be involved.
I am running 0.82 with no problems other than I seem to have a habit of buying devices that are not directly supported yet by OpenZwave and having to write my own .xml files to get at some of their features. It may be worth upgrading to that if you can - the pace of development is quite quick on this project and the devs seem to be fixing stuff pretty rapidly.
As a result of the pace of development, make sure you can back out failed updates safely. It depends on your approach to risk but I would suggest that time spent on how to revert changes and deal with hardware failure is time well spent.
Thx for your detailed reply
Normal log before doing anything
-11-23 13:18:13.637 Detail, Node002, Received: 0x01, 0x09, 0x00, 0x04, 0x04, 0x02, 0x03, 0x80, 0x03, 0x64, 0x10
2018-11-23 13:18:13.637 Detail,
2018-11-23 13:18:13.638 Info, Node002, Received Battery report from node 2: level=100
2018-11-23 13:18:13.638 Detail, Node002, Refreshed Value: old value=100, new value=100, type=byte
2018-11-23 13:18:13.638 Detail, Node002, Changes to this value are not verified
2018-11-23 13:18:13.638 Detail, Node002, Notification: ValueChanged
2018-11-23 13:18:13.701 Detail, Node002, Received: 0x01, 0x0c, 0x00, 0x04, 0x00, 0x02, 0x06, 0x31, 0x05, 0x03, 0x0a, 0x00, 0x00, 0xce
2018-11-23 13:18:13.701 Detail,
2018-11-23 13:18:13.702 Info, Node002, Received SensorMultiLevel report from node 2, instance 1, Luminance: value=0lux
2018-11-23 13:18:13.702 Detail, Node002, Refreshed Value: old value=0, new value=0, type=decimal
2018-11-23 13:18:13.702 Detail, Node002, Changes to this value are not verified
2018-11-23 13:18:13.702 Detail, Node002, Notification: ValueChanged
2018-11-23 13:18:13.740 Detail, Node002, Received: 0x01, 0x0c, 0x00, 0x04, 0x04, 0x02, 0x06, 0x31, 0x05, 0x03, 0x0a, 0x00, 0x00, 0xca
2018-11-23 13:18:13.744 Detail,
2018-11-23 13:18:13.744 Info, Node002, Received SensorMultiLevel report from node 2, instance 1, Luminance: value=0lux
2018-11-23 13:18:13.744 Detail, Node002, Refreshed Value: old value=0, new value=0, type=decimal
2018-11-23 13:18:13.744 Detail, Node002, Changes to this value are not verified
2018-11-23 13:18:13.745 Detail, Node002, Notification: ValueChanged
2018-11-23 13:18:13.841 Detail, Node002, Received: 0x01, 0x0b, 0x00, 0x04, 0x00, 0x02, 0x05, 0x31, 0x05, 0x1b, 0x01, 0x00, 0xd9
2018-11-23 13:18:13.841 Detail,
2018-11-23 13:18:13.841 Info, Node002, Received SensorMultiLevel report from node 2, instance 1, Ultraviolet: value=0
2018-11-23 13:18:13.841 Detail, Node002, Refreshed Value: old value=0, new value=0, type=decimal
2018-11-23 13:18:13.841 Detail, Node002, Changes to this value are not verified
2018-11-23 13:18:13.841 Detail, Node002, Notification: ValueChanged
2018-11-23 13:18:13.880 Detail, Node002, Received: 0x01, 0x0b, 0x00, 0x04, 0x04, 0x02, 0x05, 0x31, 0x05, 0x1b, 0x01, 0x00, 0xdd
2018-11-23 13:18:13.880 Detail,
2018-11-23 13:18:13.880 Info, Node002, Received SensorMultiLevel report from node 2, instance 1, Ultraviolet: value=0
2018-11-23 13:18:13.880 Detail, Node002, Refreshed Value: old value=0, new value=0, type=decimal
2018-11-23 13:18:13.880 Detail, Node002, Changes to this value are not verified
2018-11-23 13:18:13.881 Detail, Node002, Notification: ValueChanged
Log after hiting node refresh in the home assistant panel
2018-11-23 13:20:57.292 Detail, Node003, AdvanceQueries queryPending=0 queryRetries=0 queryStage=ProtocolInfo live=1
2018-11-23 13:20:57.300 Detail, Node003, QueryStage_Probe
2018-11-23 13:20:57.300 Info, Node003, NoOperation::Set - Routing=true
2018-11-23 13:20:57.300 Detail,
2018-11-23 13:20:57.300 Detail, Node003, Queuing (WakeUp) NoOperation_Set (Node=3): 0x01, 0x09, 0x00, 0x13, 0x03, 0x02, 0x00, 0x00, 0x25, 0x34, 0xf5
2018-11-23 13:20:57.300 Info,
2018-11-23 13:20:57.300 Detail, Node003, Queuing (WakeUp) Query Stage Complete (Probe)
Log after hitting Heal network:
2018-11-23 13:23:13.418 Detail, Node002, Removing current message
2018-11-23 13:23:13.418 Detail, Notification: ControllerCommand - InProgress
2018-11-23 13:23:13.419 Info, WriteNextMsg Controller nothing to do
2018-11-23 13:23:13.701 Detail, Received: 0x01, 0x05, 0x00, 0x48, 0x36, 0x22, 0xa6
2018-11-23 13:23:13.701 Detail,
2018-11-23 13:23:13.701 Info, REQUEST_NEIGHBOR_UPDATE_DONE
2018-11-23 13:23:13.701 Detail, Requesting routing info (neighbor list) for Node 2
2018-11-23 13:23:13.701 Detail, Node002, Queuing (Command) Get Routing Info (Node=2): 0x01, 0x07, 0x00, 0x80, 0x02, 0x00, 0x00, 0x03, 0x79
2018-11-23 13:23:13.701 Detail, Notification: ControllerCommand - Completed
2018-11-23 13:23:13.702 Detail,
2018-11-23 13:23:13.702 Info, Node002, Sending (Command) message (Callback ID=0x00, Expected Reply=0x80) - Get Routing Info (Node=2): 0x01, 0x07, 0x00, 0x80, 0x02, 0x00, 0x00, 0x03, 0x79
2018-11-23 13:23:13.711 Detail, Node002, Received: 0x01, 0x20, 0x01, 0x80, 0x0d, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x53
2018-11-23 13:23:13.711 Detail,
2018-11-23 13:23:13.711 Info, Node002, Received reply to FUNC_ID_ZW_GET_ROUTING_INFO
2018-11-23 13:23:13.711 Info, Node002, Neighbors of this node are:
2018-11-23 13:23:13.711 Info, Node002, Node 1
2018-11-23 13:23:13.711 Info, Node002, Node 3
2018-11-23 13:23:13.711 Info, Node002, Node 4
2018-11-23 13:23:13.711 Detail, Expected reply was received
2018-11-23 13:23:13.711 Detail, Message transaction complete
2018-11-23 13:23:13.711 Detail,
2018-11-23 13:23:13.711 Detail, Node002, Removing current message
2018-11-23 13:23:13.711 Info, Requesting Neighbor Update for node 3
2018-11-23 13:23:13.711 Detail,
2018-11-23 13:23:13.711 Detail, Node003, Queuing (Controller) Request Node Neighbor Update
2018-11-23 13:23:13.711 Detail, Notification: ControllerCommand - Starting
2018-11-23 13:23:13.712 Detail, Notification: ControllerCommand - Sleeping
2018-11-23 13:23:13.713 Info, Requesting Neighbor Update for node 4
2018-11-23 13:23:13.713 Detail, Node004, Queuing (Command) ControllerCommand_RequestNodeNeighborUpdate (Node=4): 0x01, 0x05, 0x00, 0x48, 0x04, 0x38, 0x8e
2018-11-23 13:23:13.713 Detail, Notification: ControllerCommand - Starting
2018-11-23 13:23:13.713 Detail,
2018-11-23 13:23:13.713 Info, Node004, Sending (Command) message (Callback ID=0x38, Expected Reply=0x48) - ControllerCommand_RequestNodeNeighborUpdate (Node=4): 0x01, 0x05, 0x00, 0x48, 0x04, 0x38, 0x8e
2018-11-23 13:23:13.752 Detail, Node004, Received: 0x01, 0x05, 0x00, 0x48, 0x38, 0x21, 0xab
2018-11-23 13:23:13.752 Detail,
2018-11-23 13:23:13.752 Info, Node004, REQUEST_NEIGHBOR_UPDATE_STARTED
2018-11-23 13:23:13.752 Detail, Node033, Expected callbackId was received
2018-11-23 13:23:13.753 Detail, Node033, Expected reply was received
2018-11-23 13:23:13.753 Detail, Node033, Message transaction complete
2018-11-23 13:23:13.753 Detail,
2018-11-23 13:23:13.753 Detail, Node004, Removing current message
2018-11-23 13:23:13.753 Detail, Notification: ControllerCommand - InProgress
2018-11-23 13:23:13.754 Info, WriteNextMsg Controller nothing to do
2018-11-23 13:23:14.039 Detail, Received: 0x01, 0x05, 0x00, 0x48, 0x38, 0x22, 0xa8
2018-11-23 13:23:14.039 Detail,
2018-11-23 13:23:14.039 Info, REQUEST_NEIGHBOR_UPDATE_DONE
2018-11-23 13:23:14.039 Detail, Requesting routing info (neighbor list) for Node 4
2018-11-23 13:23:14.039 Detail, Node004, Queuing (Command) Get Routing Info (Node=4): 0x01, 0x07, 0x00, 0x80, 0x04, 0x00, 0x00, 0x03, 0x7f
2018-11-23 13:23:14.039 Detail, Notification: ControllerCommand - Completed
2018-11-23 13:23:14.040 Detail,
2018-11-23 13:23:14.040 Info, Node004, Sending (Command) message (Callback ID=0x00, Expected Reply=0x80) - Get Routing Info (Node=4): 0x01, 0x07, 0x00, 0x80, 0x04, 0x00, 0x00, 0x03, 0x7f
2018-11-23 13:23:14.051 Detail, Node004, Received: 0x01, 0x20, 0x01, 0x80, 0x03, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x5d
2018-11-23 13:23:14.051 Detail,
2018-11-23 13:23:14.051 Info, Node004, Received reply to FUNC_ID_ZW_GET_ROUTING_INFO
2018-11-23 13:23:14.052 Info, Node004, Neighbors of this node are:
2018-11-23 13:23:14.052 Info, Node004, Node 1
2018-11-23 13:23:14.052 Info, Node004, Node 2
2018-11-23 13:23:14.052 Detail, Expected reply was received
2018-11-23 13:23:14.052 Detail, Message transaction complete
2018-11-23 13:23:14.052 Detail,
2018-11-23 13:23:14.052 Detail, Node004, Removing current message
Bump, any ideas?
What isn’t working exactly? When you open and close a door you’re not getting a change in the sensor values? Or are you concerned about the “Initializing (Probe)” status? That can be normal for some battery devices.
Can you show the logs when you open and close the door? You can remove everything except the lines with Node003
.
Strangely I am just about to post on a very similar 0.83.2 related Z-Wave issue…
Since upgrading to 0.83.x half of my Z-wave network seems to have vanished! Some of my NeoCoolcam DOOR and PIR sensors and a smart plug are still missing - managed to get a couple of the DOOR sensors to wake up again:
Strangely my Z-Wave visualisation using the latest non code version has stopped working and I get no representation of my Z-wave map anymore.
Here is my list of Z-wave nodes:
It maybe feels like the code is going one at a time through the list of sleeping nodes and not doing anything else until they wake up - yesterday node 6 was at the bottom of the list now there is 17.
I have Z-Wave debug turned on and can see for example NODE-24 which I just woke up via the button (Its one of the PIRs)
Dec 02 09:34:07 docker c292dbc3479e[1188]: 2018-12-02 09:34:07.304 Info, Node024, UPDATE_STATE_NODE_INFO_RECEIVED from node 24
Dec 02 09:34:07 docker c292dbc3479e[1188]: 2018-12-02 09:34:07.304 Detail, Node024, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Dynamic live=1
Dec 02 09:34:07 docker c292dbc3479e[1188]: 2018-12-02 09:34:07.304 Detail, Node024, QueryStage_Dynamic
Dec 02 09:34:07 docker c292dbc3479e[1188]: 2018-12-02 09:34:07.304 Detail,
Dec 02 09:34:07 docker c292dbc3479e[1188]: 2018-12-02 09:34:07.304 Detail, Node024, Queuing (WakeUp) BasicCmd_Get (Node=24): 0x01, 0x09, 0x00, 0x13, 0x18, 0x02, 0x20, 0x02, 0x25, 0x6b, 0x93
Dec 02 09:34:07 docker c292dbc3479e[1188]: 2018-12-02 09:34:07.304 Info,
Dec 02 09:34:07 docker c292dbc3479e[1188]: 2018-12-02 09:34:07.304 Detail, Node024, Queuing (WakeUp) Query Stage Complete (Dynamic)
Dec 02 09:34:07 docker c292dbc3479e[1188]: 2018-12-02 09:34:07.304 Info, Node024, Node 24 has been marked as awake
Dec 02 09:34:07 docker c292dbc3479e[1188]: 2018-12-02 09:34:07.304 Detail, Node024, Queuing (WakeUp) BasicCmd_Get (Node=24): 0x01, 0x09, 0x00, 0x13, 0x18, 0x02, 0x20, 0x02, 0x25, 0x6b, 0x93
Dec 02 09:34:07 docker c292dbc3479e[1188]: 2018-12-02 09:34:07.304 Detail, Node024, Queuing (Query) Query Stage Complete (Dynamic)
Dec 02 09:34:07 docker c292dbc3479e[1188]: 2018-12-02 09:34:07.304 Detail, Node024, Notification: Notification - Node Awake
Dec 02 09:34:07 docker c292dbc3479e[1188]:
Dec 02 09:34:07 docker c292dbc3479e[1188]: SIGNAL ***** Notification
I might just wait in the hope that mode nodes will add over time.
Doesn’t explain why the mapping no longer works though.
Adrian
Well i got it back working.
Dont ask me how, i took out the batteries pressed on all possible buttons and it got recognised