Zwave2mqtt: Battery powered sensors dead on restart

[Altycoder]

I've just tried to migrate my zwave setup to zwave2mqtt from home assistant's internal zwave ahead of any future breaking changes.

Whilst I've had things working with HA for over a year now, the same zwave controller and sensors aren't working with zwave2mqtt. The controller is a ZME EU UZB1 and I have 4 door sensors which are detected as "Kaipule Technology Co. Ltd" IM20 sensors.

I can get the sensors to be detected by zwave2mqtt initially and they report the correct battery level, but the open/closing of the doors isn't registered by zwave2mqtt or HA.

After a while or on restart the sensors all become dead and that's that.

In HA via mosquitto MQTT, I have 8 sensors listed, some are node_IDX and some are the location/name specified in zwave2mqtt so there's some duplication going on.

I'm using docker for zwave2mqtt, mosquitto and HA, my docker compose is below. The host is Arch (LTS kernel).

I have also posted my zwave2mqtt config below, assume awake is selected.

version: "3"

services:

  mosquitto:
    container_name: mosquitto
    image: eclipse-mosquitto:latest
    restart: always
    volumes:
      - /mnt/btrfs_raid/docker/mosquitto/mosquitto.conf:/mosquitto/config/mosquitto.conf
      - /mnt/btrfs_raid/docker/mosquitto/data:/mosquitto/data
      - /mnt/btrfs_raid/docker/mosquitto/log:/mosquitto/log
    ports:
      - 1883:1883
      - 9001:9001

  zwave2mqtt:
    container_name: zwave2mqtt
    image: robertslando/zwave2mqtt:latest
    restart: always
    tty: true
    stop_signal: SIGINT
    networks:
      - zwave
    devices:
      - /dev/ttyACM0:/dev/ttyACM0
    volumes:
      - /mnt/btrfs_raid/docker/zwave2mqtt/store:/usr/src/app/store
    ports:
      - 8091:8091

  homeassistant:
    container_name: home-assistant
    image: homeassistant/home-assistant:latest
    volumes:
      - /mnt/btrfs_raid/docker/home-assistant:/config
      - /etc/localtime:/etc/localtime:ro
    environment:
      - TZ=Europe/London
    dns:
      - 9.9.9.9
      - 1.1.1.1
    restart: always
    network_mode: host

  networks:
    zwave:

[Altycoder]

Some extra screens (I only got round to adding 3 of the 4 sensors)

[robertsLando]

@sarkyscouser Did you remove them after migrating from the other zwave instance? I mean did you start with a 'fresh' usb controller without any node paired?

[Altycoder]

Yes, I used "ZMESerialUpdater" from the manufacturer to factory reset the controller first then rebooted. I noticed a closed bug regarding duplicate sensors when they are renamed so that's still an issue. There's also a closed bug on dead sensors but that looks specific to another brand of sensors.

I can afford to keep my system like this for another 48 hours if there's any further info I can provide, but on Thursday I need to move it back to HA's inbuilt zwave ahead of the weekend.

[robertsLando]

@Fishwaldo What could be the problem here?

[Fishwaldo]

278?

[robertsLando]

Seems that there was a problem with openzwave-shared not taking the correct paths, don't know why this was working before. Anyway now should be fixed. Will release Z2M 3.0.0 on docker in few hours

[Altycoder]

I will pull the new image later and report back

[robertsLando]

Hold a bit, it’s still building.

On 3 Mar 2020, at 12:26, sarkyscouser [e-mail] wrote:


I will pull the new image later and report back

—
You are receiving this because you modified the open/close state.
Reply to this email directly, view it on GitHub, or unsubscribe.

[Altycoder]

Just got a new image. Removed and re-added 2 sensors both die after 1-2 min and before they die they permanently report "closed" status - they don't update when the doors are opened.

[robertsLando]

Is it the 3.0.0?

[robertsLando]

@Fishwaldo

[Altycoder]

It say openzwave v 1.6.1045 in the dashboard now, can't see any other version numbers in the logs via portainer

[Altycoder]

Does this help:

z2m:Store scenes.json not found +0ms
,  z2m:Gateway No customDevices file found +0ms
,  z2m:App Application path:/usr/src/app +0ms
,Initialising OpenZWave 1.6.1045 binary addon for Node.JS.
,   OpenZWave Security API is ENABLED
,   ZWave device db    : /usr/local/etc/openzwave
,   User settings path : /usr/src/app/store
,   Option Overrides : --Logging true --ConsoleOutput true --QueueLogLevel 8 --DriverMaxAttempts 9999 --SaveConfiguration true --PollInterval 1000 --AutoUpdateConfigFile true --AssumeAwake true
,  z2m:Zwave Connecting to /dev/ttyACM0 +0ms
,2020-03-03 13:19:30.240 Always, OpenZwave Version 1.6-1045-g8ca59b1d Starting Up
,2020-03-03 13:19:30.245 Info, Loading Localization File /usr/local/etc/openzwave/Localization.xml
,2020-03-03 13:19:30.245 Info, Loaded /usr/local/etc/openzwave/Localization.xml With Revision 8
,2020-03-03 13:19:30.246 Always, Using Language Localization 
,2020-03-03 13:19:30.247 Info, Loading NotificationCCTypes File /usr/local/etc/openzwave/NotificationCCTypes.xml
,2020-03-03 13:19:30.247 Info, Loaded /usr/local/etc/openzwave/NotificationCCTypes.xml With Revision 9
,2020-03-03 13:19:30.248 Info, Loading SensorMultiLevelCCTypes File /usr/local/etc/openzwave/SensorMultiLevelCCTypes.xml
,2020-03-03 13:19:30.248 Info, Loaded /usr/local/etc/openzwave/SensorMultiLevelCCTypes.xml With Revision 3
,2020-03-03 13:19:30.248 Info, Setting Up Provided Network Key for Secure Communications
,2020-03-03 13:19:30.248 Warning, Failed - Network Key Not Set
,2020-03-03 13:19:30.258 Info, Manufacturer_Specific.xml file Revision is 78
,2020-03-03 13:19:30.443 Info, Product name collision: FGR223 Roller Shutter Controller 3 type 303 id 1000 manufacturerid 10f, collides with FGRM223 Roller Shutter Controller 3, type 303 id 1000 manufacturerid 10f
,2020-03-03 13:19:30.565 Info, Product name collision: ED2.0 Meter Adapter type 0 id 0 manufacturerid 128, collides with ED2.0 Meter Adapter, type 0 id 0 manufacturerid 128
,2020-03-03 13:19:30.565 Info, Product name collision: ED2.0 Display type 128 id 0 manufacturerid 128, collides with ED2.0 Display, type 128 id 0 manufacturerid 128
,2020-03-03 13:19:30.626 Info, Product name collision: GR105 Auto Valve type 202 id 511 manufacturerid 152, collides with GR105 Auto Valve, type 202 id 511 manufacturerid 152
,2020-03-03 13:19:30.626 Info, Product name collision: GR105n Auto Valve type 3 id 512 manufacturerid 152, collides with GR105n Auto Valve, type 3 id 512 manufacturerid 152
,2020-03-03 13:19:30.626 Info, Product name collision: ZSE02 Motion Sensor type 500 id 3 manufacturerid 152, collides with ZSE02 Motion Sensor, type 500 id 3 manufacturerid 152
,2020-03-03 13:19:30.635 Info, Product name collision: ZWN-BPC Ceiling Mounted PIR Motion Sensor type 601 id 901 manufacturerid 11a, collides with ZWN-BPC Ceiling Mounted PIR Motion Sensor, type 601 id 901 manufacturerid 11a
,2020-03-03 13:19:30.635 Info, Product name collision: ZWN-SC7 7-Button Scene Controller type 801 id b03 manufacturerid 11a, collides with ZWN-SC7 7-Button Scene Controller, type 801 id b03 manufacturerid 11a
,2020-03-03 13:19:30.635 Info, Product name collision: ZW15S 15A On/Off Switch type 101 id 102 manufacturerid 11a, collides with ZW15S 15A On/Off Switch, type 101 id 102 manufacturerid 11a
,2020-03-03 13:19:30.635 Info, Product name collision: ZW20R 20A TR Duplex Receptacle type 101 id 603 manufacturerid 11a, collides with ZW20R 20A TR Duplex Receptacle, type 101 id 603 manufacturerid 11a
,2020-03-03 13:19:30.635 Info, Product name collision: ZWN-RSM1 PLUS-Smart Single Relay Switch Module type 111 id 605 manufacturerid 11a, collides with ZWN-RSM1 PLUS—Smart Single Relay Switch Module, type 111 id 605 manufacturerid 11a
,2020-03-03 13:19:30.635 Info, Product name collision: ZW20RM 20A TR Smart Meter Duplex Receptacle type 111 id 101 manufacturerid 11a, collides with ZW20RM 20A TR Smart Meter Duplex Receptacle, type 111 id 101 manufacturerid 11a
,2020-03-03 13:19:30.635 Info, Product name collision: ZW500D 500W In-Wall Preset Dimmer Switch type 102 id 201 manufacturerid 11a, collides with ZW500D 500W In-Wall Preset Dimmer Switch, type 102 id 201 manufacturerid 11a
,2020-03-03 13:19:30.635 Info, Product name collision: ZW15RM Plus 15A TR Smart Meter Duplex Receptacle type 111 id 105 manufacturerid 11a, collides with ZW15RM Plus 15A TR Smart Meter Duplex Receptacle, type 111 id 105 manufacturerid 11a
,2020-03-03 13:19:30.662 Info, Queuing Lookup on mfs.db.openzwave.com for Node 0
,2020-03-03 13:19:30.663 Info, mgr,     Added driver for controller /dev/ttyACM0
,2020-03-03 13:19:30.663 Info, Timer: thread starting
,2020-03-03 13:19:30.663 Detail, Timer: waiting with timeout -1 ms
,2020-03-03 13:19:30.663 Info, Starting DNSThread
,2020-03-03 13:19:30.663 Info, LookupTxT Checking mfs.db.openzwave.com
,2020-03-03 13:19:30.663 Info,   Opening controller /dev/ttyACM0
,  z2m:Zwave Zwave connected, Openzwave version: 1.6.1045 +423ms
,2020-03-03 13:19:30.663 Info, Trying to open serial port /dev/ttyACM0 (attempt 1)
,2020-03-03 13:19:30.664 Info, Lookup for mfs.db.openzwave.com returned 78
,2020-03-03 13:19:30.664 Info, Serial port /dev/ttyACM0 opened (attempt 1)
,2020-03-03 13:19:30.664 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_GET_VERSION: 0x01, 0x03, 0x00, 0x15, 0xe9
,2020-03-03 13:19:30.666 Info, ManufacturerSpecificDB Initialized
,2020-03-03 13:19:30.666 Detail, Notification: ManufacturerSpecificDB Ready
,2020-03-03 13:19:30.666 Detail, 
,2020-03-03 13:19:30.666 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x15) - FUNC_ID_ZW_GET_VERSION: 0x01, 0x03, 0x00, 0x15, 0xe9
,2020-03-03 13:19:30.666 Info, contrlr, Encrypted Flag is 0
,2020-03-03 13:19:30.668 Detail, contrlr,   Received: 0x01, 0x10, 0x01, 0x15, 0x5a, 0x2d, 0x57, 0x61, 0x76, 0x65, 0x20, 0x34, 0x2e, 0x36, 0x31, 0x00, 0x01, 0x95
,2020-03-03 13:19:30.668 Detail, 
,2020-03-03 13:19:30.668 Info, contrlr, Received reply to FUNC_ID_ZW_GET_VERSION:
,2020-03-03 13:19:30.668 Info, contrlr,     Static Controller library, version Z-Wave 4.61
,2020-03-03 13:19:30.668 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_MEMORY_GET_ID: 0x01, 0x03, 0x00, 0x20, 0xdc
,2020-03-03 13:19:30.668 Detail, contrlr,   Expected reply was received
,2020-03-03 13:19:30.668 Detail, contrlr,   Message transaction complete
,2020-03-03 13:19:30.669 Detail, 
,2020-03-03 13:19:30.669 Detail, contrlr, Removing current message
,2020-03-03 13:19:30.669 Detail, 
,2020-03-03 13:19:30.669 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x20) - FUNC_ID_ZW_MEMORY_GET_ID: 0x01, 0x03, 0x00, 0x20, 0xdc
,2020-03-03 13:19:30.669 Info, contrlr, Encrypted Flag is 0
,2020-03-03 13:19:30.671 Detail, contrlr,   Received: 0x01, 0x08, 0x01, 0x20, 0xf7, 0x14, 0x8d, 0x95, 0x01, 0x2c
,2020-03-03 13:19:30.671 Detail, 
,2020-03-03 13:19:30.671 Info, contrlr, Received reply to FUNC_ID_ZW_MEMORY_GET_ID. Home ID = 0xf7148d95.  Our node ID = 1
,2020-03-03 13:19:30.671 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_GET_CONTROLLER_CAPABILITIES: 0x01, 0x03, 0x00, 0x05, 0xf9
,2020-03-03 13:19:30.671 Detail, contrlr,   Expected reply was received
,2020-03-03 13:19:30.671 Detail, contrlr,   Message transaction complete
,2020-03-03 13:19:30.671 Detail, 
,2020-03-03 13:19:30.671 Detail, contrlr, Removing current message
,2020-03-03 13:19:30.671 Detail, 
,2020-03-03 13:19:30.671 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x05) - FUNC_ID_ZW_GET_CONTROLLER_CAPABILITIES: 0x01, 0x03, 0x00, 0x05, 0xf9
,2020-03-03 13:19:30.671 Info, contrlr, Encrypted Flag is 0
,2020-03-03 13:19:30.673 Detail, contrlr,   Received: 0x01, 0x04, 0x01, 0x05, 0x08, 0xf7
,2020-03-03 13:19:30.673 Detail, 
,2020-03-03 13:19:30.673 Info, contrlr, Received reply to FUNC_ID_ZW_GET_CONTROLLER_CAPABILITIES:
,2020-03-03 13:19:30.673 Info, contrlr,     There is no SUC ID Server (SIS) in this network.
,2020-03-03 13:19:30.673 Info, contrlr,     The PC controller is a primary controller.
,2020-03-03 13:19:30.673 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_GET_SUC_NODE_ID: 0x01, 0x03, 0x00, 0x56, 0xaa
,2020-03-03 13:19:30.673 Detail, contrlr,   Expected reply was received
,2020-03-03 13:19:30.673 Detail, contrlr,   Message transaction complete
,2020-03-03 13:19:30.673 Detail, 
,2020-03-03 13:19:30.673 Detail, contrlr, Removing current message
,2020-03-03 13:19:30.673 Detail, 
,2020-03-03 13:19:30.673 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x56) - FUNC_ID_ZW_GET_SUC_NODE_ID: 0x01, 0x03, 0x00, 0x56, 0xaa
,2020-03-03 13:19:30.673 Info, contrlr, Encrypted Flag is 0
,2020-03-03 13:19:30.675 Detail, contrlr,   Received: 0x01, 0x04, 0x01, 0x56, 0x00, 0xac
,2020-03-03 13:19:30.675 Detail, 
,2020-03-03 13:19:30.675 Info, contrlr, Received reply to GET_SUC_NODE_ID.  Node ID = 0
,2020-03-03 13:19:30.675 Info, Controller Does not Support SUC - Cannot Setup Controller as SUC Node
,2020-03-03 13:19:30.675 Detail, contrlr, Queuing (Command) FUNC_ID_SERIAL_API_GET_CAPABILITIES: 0x01, 0x03, 0x00, 0x07, 0xfb
,2020-03-03 13:19:30.675 Detail, contrlr,   Expected reply was received
,2020-03-03 13:19:30.675 Detail, contrlr,   Message transaction complete
,2020-03-03 13:19:30.675 Detail, 
,2020-03-03 13:19:30.675 Detail, contrlr, Removing current message
,2020-03-03 13:19:30.675 Detail, 
,2020-03-03 13:19:30.675 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x07) - FUNC_ID_SERIAL_API_GET_CAPABILITIES: 0x01, 0x03, 0x00, 0x07, 0xfb
,2020-03-03 13:19:30.675 Info, contrlr, Encrypted Flag is 0
,2020-03-03 13:19:30.679 Detail, contrlr,   Received: 0x01, 0x2b, 0x01, 0x07, 0x05, 0x19, 0x01, 0x15, 0x04, 0x00, 0x00, 0x01, 0xfe, 0x85, 0x7f, 0x88, 0xcf, 0x3f, 0xc0, 0x47, 0xfb, 0xdf, 0xfd, 0xe0, 0x67, 0x00, 0x80, 0x80, 0x00, 0x80, 0x86, 0x00, 0x00, 0x00, 0xe8, 0x73, 0x00, 0x80, 0x0f, 0x00, 0x00, 0x60, 0x5a, 0x00, 0x52
,2020-03-03 13:19:30.679 Detail, 
,2020-03-03 13:19:30.679 Info, contrlr,  Received reply to FUNC_ID_SERIAL_API_GET_CAPABILITIES
,2020-03-03 13:19:30.679 Info, contrlr,     Serial API Version:   5.25
,2020-03-03 13:19:30.679 Info, contrlr,     Manufacturer ID:      0x0115
,2020-03-03 13:19:30.679 Info, contrlr,     Product Type:         0x0400
,2020-03-03 13:19:30.679 Info, contrlr,     Product ID:           0x0001
,2020-03-03 13:19:30.679 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_GET_RANDOM: 0x01, 0x04, 0x00, 0x1c, 0x20, 0xc7
,2020-03-03 13:19:30.679 Detail, contrlr, Queuing (Command) FUNC_ID_SERIAL_API_SETUP: 0x01, 0x05, 0x00, 0x0b, 0x02, 0x01, 0xf2
,2020-03-03 13:19:30.680 Detail, contrlr, Queuing (Command) FUNC_ID_SERIAL_API_GET_INIT_DATA: 0x01, 0x03, 0x00, 0x02, 0xfe
,2020-03-03 13:19:30.680 Detail, contrlr, Queuing (Command) FUNC_ID_SERIAL_API_SET_TIMEOUTS: 0x01, 0x05, 0x00, 0x06, 0x64, 0x0f, 0x97
,2020-03-03 13:19:30.680 Detail, contrlr, Queuing (Command) FUNC_ID_SERIAL_API_APPL_NODE_INFORMATION: 0x01, 0x08, 0x00, 0x03, 0x01, 0x02, 0x01, 0x01, 0x5e, 0xa9
,2020-03-03 13:19:30.680 Detail, contrlr,   Expected reply was received
,2020-03-03 13:19:30.680 Detail, contrlr,   Message transaction complete
,2020-03-03 13:19:30.680 Detail, 
,2020-03-03 13:19:30.680 Detail, contrlr, Removing current message
,2020-03-03 13:19:30.680 Detail, 
,2020-03-03 13:19:30.681 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x1c) - FUNC_ID_ZW_GET_RANDOM: 0x01, 0x04, 0x00, 0x1c, 0x20, 0xc7
,2020-03-03 13:19:30.681 Info, contrlr, Encrypted Flag is 0
,  z2m:App Listening on port 8091 +0ms
,  z2m:Mqtt MQTT client connected +0ms
,  z2m:App New connection 50JzpvIIXaPvpNoVAAAA +506ms
,2020-03-03 13:19:30.737 Detail, contrlr,   Received: 0x01, 0x25, 0x01, 0x1c, 0x01, 0x20, 0x3e, 0xf3, 0x06, 0xf5, 0x91, 0xce, 0xe9, 0x7f, 0xf3, 0x36, 0x5c, 0x02, 0x54, 0xe7, 0xa6, 0x52, 0xec, 0xfc, 0xc5, 0xb8, 0x8e, 0x14, 0x66, 0xbe, 0x65, 0xfe, 0x86, 0x8c, 0x1d, 0xf7, 0x3f, 0xd4, 0x72
,2020-03-03 13:19:30.737 Detail, 
,2020-03-03 13:19:30.737 Info, Received reply to FUNC_ID_ZW_GET_RANDOM: true
,2020-03-03 13:19:30.737 Detail, contrlr,   Expected reply was received
,2020-03-03 13:19:30.737 Detail, contrlr,   Message transaction complete
,2020-03-03 13:19:30.737 Detail, 
,2020-03-03 13:19:30.737 Detail, contrlr, Removing current message
,2020-03-03 13:19:30.737 Detail, 
,2020-03-03 13:19:30.737 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x0b) - FUNC_ID_SERIAL_API_SETUP: 0x01, 0x05, 0x00, 0x0b, 0x02, 0x01, 0xf2
,2020-03-03 13:19:30.737 Info, contrlr, Encrypted Flag is 0
,2020-03-03 13:19:30.742 Detail, contrlr,   Received: 0x01, 0x05, 0x01, 0x0b, 0x02, 0x01, 0xf3
,2020-03-03 13:19:30.742 Detail, 
,2020-03-03 13:19:30.742 Info, Received reply to FUNC_ID_SERIAL_API_SETUP
,2020-03-03 13:19:30.742 Info, Successfully enabled extended txStatusReport.
,2020-03-03 13:19:30.742 Detail, contrlr,   Expected reply was received
,2020-03-03 13:19:30.742 Detail, contrlr,   Message transaction complete
,2020-03-03 13:19:30.742 Detail, 
,2020-03-03 13:19:30.742 Detail, contrlr, Removing current message
,2020-03-03 13:19:30.742 Detail, 
,2020-03-03 13:19:30.742 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x02) - FUNC_ID_SERIAL_API_GET_INIT_DATA: 0x01, 0x03, 0x00, 0x02, 0xfe
,2020-03-03 13:19:30.742 Info, contrlr, Encrypted Flag is 0
,2020-03-03 13:19:30.841 Detail, contrlr,   Received: 0x01, 0x25, 0x01, 0x02, 0x06, 0x00, 0x1d, 0x39, 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, 0x05, 0x00, 0xfe
,2020-03-03 13:19:30.841 Detail, 
,2020-03-03 13:19:30.841 Info, mgr,     Driver with Home ID of 0xf7148d95 is now ready.
,2020-03-03 13:19:30.841 Info, 
,2020-03-03 13:19:30.846 Info, Node001, (32 - COMMAND_CLASS_BASIC) - Compatibility Flags:
,2020-03-03 13:19:30.846 Info, Node001, (32 - COMMAND_CLASS_BASIC) - State Flags:
,2020-03-03 13:19:30.846 Info, Node001,      AfterMark: true
,2020-03-03 13:19:30.846 Info, Node001, (114 - COMMAND_CLASS_MANUFACTURER_SPECIFIC) - Compatibility Flags:
,2020-03-03 13:19:30.846 Info, Node001, (114 - COMMAND_CLASS_MANUFACTURER_SPECIFIC) - State Flags:
,2020-03-03 13:19:30.846 Info, Node001,      StaticRequests: 2
,2020-03-03 13:19:30.847 Info, Node006, (32 - COMMAND_CLASS_BASIC) - Compatibility Flags:
,2020-03-03 13:19:30.847 Info, Node006, (32 - COMMAND_CLASS_BASIC) - State Flags:
,2020-03-03 13:19:30.848 Info, Node006,      CCVersion: 1
,2020-03-03 13:19:30.848 Info, Node006,      StaticRequests: 4
,2020-03-03 13:19:30.848 Info, Node006, (48 - COMMAND_CLASS_SENSOR_BINARY) - Compatibility Flags:
,2020-03-03 13:19:30.848 Info, Node006, (48 - COMMAND_CLASS_SENSOR_BINARY) - State Flags:
,2020-03-03 13:19:30.848 Info, Node006,      CCVersion: 1
,2020-03-03 13:19:30.848 Info, Node006,      InNif: true
,2020-03-03 13:19:30.848 Info, Node006,      StaticRequests: 4
,2020-03-03 13:19:30.848 Info, Node006, (90 - COMMAND_CLASS_DEVICE_RESET_LOCALLY) - Compatibility Flags:
,2020-03-03 13:19:30.848 Info, Node006, (90 - COMMAND_CLASS_DEVICE_RESET_LOCALLY) - State Flags:
,2020-03-03 13:19:30.848 Info, Node006,      CCVersion: 1
,2020-03-03 13:19:30.848 Info, Node006,      InNif: true
,2020-03-03 13:19:30.848 Info, Node006,      StaticRequests: 4
,2020-03-03 13:19:30.848 Info, Node006, (94 - COMMAND_CLASS_ZWAVEPLUS_INFO) - Compatibility Flags:
,2020-03-03 13:19:30.848 Info, Node006, (94 - COMMAND_CLASS_ZWAVEPLUS_INFO) - State Flags:
,2020-03-03 13:19:30.849 Info, Node006,      CCVersion: 1
,2020-03-03 13:19:30.849 Info, Node006,      InNif: true
,2020-03-03 13:19:30.849 Info, Node006,      StaticRequests: 6
,2020-03-03 13:19:30.849 Info, Node006, (112 - COMMAND_CLASS_CONFIGURATION) - Compatibility Flags:
,2020-03-03 13:19:30.849 Info, Node006, (112 - COMMAND_CLASS_CONFIGURATION) - State Flags:
,2020-03-03 13:19:30.849 Info, Node006,      CCVersion: 1
,2020-03-03 13:19:30.849 Info, Node006,      InNif: true
,2020-03-03 13:19:30.849 Info, Node006,      StaticRequests: 4
,2020-03-03 13:19:30.849 Info, Node006, (113 - COMMAND_CLASS_NOTIFICATION) - Compatibility Flags:
,2020-03-03 13:19:30.849 Info, Node006, (113 - COMMAND_CLASS_NOTIFICATION) - State Flags:
,2020-03-03 13:19:30.849 Info, Node006,      CCVersion: 4
,2020-03-03 13:19:30.849 Info, Node006,      InNif: true
,2020-03-03 13:19:30.849 Info, Node006,      StaticRequests: 0
,2020-03-03 13:19:30.849 Warning, Value size is invalid (3). Only 1, 2 & 4 supported for node 6, class 0x71, instance 1, index 6
,2020-03-03 13:19:30.850 Info, Node006, (114 - COMMAND_CLASS_MANUFACTURER_SPECIFIC) - Compatibility Flags:
,2020-03-03 13:19:30.850 Info, Node006, (114 - COMMAND_CLASS_MANUFACTURER_SPECIFIC) - State Flags:
,2020-03-03 13:19:30.850 Info, Node006,      CCVersion: 2
,2020-03-03 13:19:30.850 Info, Node006,      InNif: true
,2020-03-03 13:19:30.850 Info, Node006,      StaticRequests: 0
,2020-03-03 13:19:30.850 Info, Node006, (115 - COMMAND_CLASS_POWERLEVEL) - Compatibility Flags:
,2020-03-03 13:19:30.850 Info, Node006, (115 - COMMAND_CLASS_POWERLEVEL) - State Flags:
,2020-03-03 13:19:30.850 Info, Node006,      CCVersion: 1
,2020-03-03 13:19:30.850 Info, Node006,      InNif: true
,2020-03-03 13:19:30.850 Info, Node006,      StaticRequests: 4
,2020-03-03 13:19:30.850 Info, Node006, (128 - COMMAND_CLASS_BATTERY) - Compatibility Flags:
,2020-03-03 13:19:30.851 Info, Node006, (128 - COMMAND_CLASS_BATTERY) - State Flags:
,2020-03-03 13:19:30.851 Info, Node006,      CCVersion: 1
,2020-03-03 13:19:30.851 Info, Node006,      InNif: true
,2020-03-03 13:19:30.851 Info, Node006,      StaticRequests: 4
,2020-03-03 13:19:30.851 Info, Node006, (132 - COMMAND_CLASS_WAKE_UP) - Compatibility Flags:
,2020-03-03 13:19:30.851 Info, Node006, (132 - COMMAND_CLASS_WAKE_UP) - State Flags:
,2020-03-03 13:19:30.851 Info, Node006,      CCVersion: 2
,2020-03-03 13:19:30.851 Info, Node006,      InNif: true
,2020-03-03 13:19:30.851 Info, Node006,      StaticRequests: 0
,2020-03-03 13:19:30.851 Info, Node006, (133 - COMMAND_CLASS_ASSOCIATION) - Compatibility Flags:
,2020-03-03 13:19:30.851 Info, Node006, (133 - COMMAND_CLASS_ASSOCIATION) - State Flags:
,2020-03-03 13:19:30.851 Info, Node006,      CCVersion: 1
,2020-03-03 13:19:30.852 Info, Node006,      InNif: true
,2020-03-03 13:19:30.852 Info, Node006,      StaticRequests: 4
,2020-03-03 13:19:30.852 Info, Node006, (134 - COMMAND_CLASS_VERSION) - Compatibility Flags:
,2020-03-03 13:19:30.852 Info, Node006, (134 - COMMAND_CLASS_VERSION) - State Flags:
,2020-03-03 13:19:30.852 Info, Node006,      CCVersion: 1
,2020-03-03 13:19:30.852 Info, Node006,      InNif: true
,2020-03-03 13:19:30.852 Info, Node006,      StaticRequests: 4
,2020-03-03 13:19:30.853 Info, contrlr, Received reply to FUNC_ID_SERIAL_API_GET_INIT_DATA:
,2020-03-03 13:19:30.853 Info, contrlr,     Node 001 - Known
,2020-03-03 13:19:30.853 Detail, Node001, AdvanceQueries queryPending=0 queryRetries=0 queryStage=CacheLoad live=1
,2020-03-03 13:19:30.853 Detail, Node001, QueryStage_CacheLoad
,2020-03-03 13:19:30.853 Info, Node001, Loading Cache for node 1: Manufacturer=Z-Wave.Me, Product=ZME_UZB1 USB Stick
,2020-03-03 13:19:30.853 Info, Node001, Node Identity Codes: 0115:0400:0001
,2020-03-03 13:19:30.853 Detail, Node001, QueryStage_Associations
,2020-03-03 13:19:30.853 Detail, Node001, QueryStage_Neighbors
,2020-03-03 13:19:30.854 Detail, contrlr, Requesting routing info (neighbor list) for Node 1
,2020-03-03 13:19:30.854 Detail, Node001, Queuing (Command) Get Routing Info (Node=1): 0x01, 0x07, 0x00, 0x80, 0x01, 0x00, 0x00, 0x03, 0x7a
,2020-03-03 13:19:30.854 Detail, Node001, Queuing (Query) Query Stage Complete (Neighbors)
,2020-03-03 13:19:30.854 Info, contrlr,     Node 004 - New
,2020-03-03 13:19:30.854 Detail, Node004, AdvanceQueries queryPending=0 queryRetries=0 queryStage=None live=1
,2020-03-03 13:19:30.854 Detail, Node004, QueryStage_ProtocolInfo
,2020-03-03 13:19:30.854 Detail, Node004, Queuing (Query) Get Node Protocol Info (Node=4): 0x01, 0x04, 0x00, 0x41, 0x04, 0xbe
,2020-03-03 13:19:30.854 Detail, Node004, Queuing (Query) Query Stage Complete (ProtocolInfo)
,2020-03-03 13:19:30.854 Info, Node004, Initializing Node. New Node: false (false)
,2020-03-03 13:19:30.854 Info, contrlr,     Node 005 - New
,2020-03-03 13:19:30.855 Detail, Node005, AdvanceQueries queryPending=0 queryRetries=0 queryStage=None live=1
,2020-03-03 13:19:30.855 Detail, Node005, QueryStage_ProtocolInfo
,2020-03-03 13:19:30.855 Detail, Node005, Queuing (Query) Get Node Protocol Info (Node=5): 0x01, 0x04, 0x00, 0x41, 0x05, 0xbf
,2020-03-03 13:19:30.855 Detail, Node005, Queuing (Query) Query Stage Complete (ProtocolInfo)
,2020-03-03 13:19:30.855 Info, Node005, Initializing Node. New Node: false (false)
,2020-03-03 13:19:30.855 Info, contrlr,     Node 006 - Known
,2020-03-03 13:19:30.855 Detail, Node006, AdvanceQueries queryPending=0 queryRetries=0 queryStage=CacheLoad live=1
,2020-03-03 13:19:30.855 Detail, Node006, QueryStage_CacheLoad
,2020-03-03 13:19:30.855 Info, Node006, Loading Cache for node 6: Manufacturer=Kaipule Technology Co. Ltd, Product=IM20 Door/Window Sensor
,2020-03-03 13:19:30.855 Info, Node006, Node Identity Codes: 0214:0002:0001
,2020-03-03 13:19:30.855 Info, Node006, NoOperation::Set - Routing=true
,2020-03-03 13:19:30.855 Detail, Node006, Queuing (NoOp) NoOperation_Set (Node=6): 0x01, 0x09, 0x00, 0x13, 0x06, 0x02, 0x00, 0x00, 0x25, 0x0a, 0xce
,2020-03-03 13:19:30.855 Detail, Node006, Queuing (Query) Query Stage Complete (CacheLoad)
,2020-03-03 13:19:30.855 Detail, contrlr,   Expected reply was received
,2020-03-03 13:19:30.856 Detail, contrlr,   Message transaction complete
,2020-03-03 13:19:30.856 Detail, 
,2020-03-03 13:19:30.856 Detail, contrlr, Removing current message
,2020-03-03 13:19:30.856 Detail, Node001, Notification: DriverReady
,2020-03-03 13:19:30.856 Detail, Node001, Notification: NodeAdded
,2020-03-03 13:19:30.856 Detail, Node001, Notification: NodeProtocolInfo
,2020-03-03 13:19:30.856 Detail, Node001, Notification: EssentialNodeQueriesComplete
,2020-03-03 13:19:30.856 Detail, Node001, Notification: ValueAdded CC: COMMAND_CLASS_BASIC Instance: 1 Index: 0
,2020-03-03 13:19:30.856 Detail, Node001, Notification: ValueAdded CC: COMMAND_CLASS_MANUFACTURER_SPECIFIC Instance: 1 Index: 0
,2020-03-03 13:19:30.856 Detail, Node001, Notification: ValueAdded CC: COMMAND_CLASS_MANUFACTURER_SPECIFIC Instance: 1 Index: 1
,2020-03-03 13:19:30.856 Detail, Node001, Notification: ValueAdded CC: COMMAND_CLASS_MANUFACTURER_SPECIFIC Instance: 1 Index: 2
,2020-03-03 13:19:30.857 Detail, Node001, Notification: ValueAdded CC: COMMAND_CLASS_MANUFACTURER_SPECIFIC Instance: 1 Index: 3
,2020-03-03 13:19:30.857 Detail, Node001, Notification: ValueAdded CC: COMMAND_CLASS_MANUFACTURER_SPECIFIC Instance: 1 Index: 4
,2020-03-03 13:19:30.857 Detail, Node001, Notification: NodeNaming
,2020-03-03 13:19:30.857 Detail, Node006, Notification: NodeAdded
,2020-03-03 13:19:30.857 Detail, Node006, Notification: NodeProtocolInfo
,2020-03-03 13:19:30.857 Detail, Node006, Notification: EssentialNodeQueriesComplete
,2020-03-03 13:19:30.857 Detail, Node006, Notification: ValueAdded CC: COMMAND_CLASS_BASIC Instance: 1 Index: 0
,2020-03-03 13:19:30.857 Detail, Node006, Notification: ValueAdded CC: COMMAND_CLASS_SENSOR_BINARY Instance: 1 Index: 0
,2020-03-03 13:19:30.857 Detail, Node006, Notification: ValueAdded CC: COMMAND_CLASS_ZWAVEPLUS_INFO Instance: 1 Index: 0
,2020-03-03 13:19:30.857 Detail, Node006, Notification: ValueAdded CC: COMMAND_CLASS_ZWAVEPLUS_INFO Instance: 1 Index: 1
,2020-03-03 13:19:30.857 Detail, Node006, Notification: ValueAdded CC: COMMAND_CLASS_ZWAVEPLUS_INFO Instance: 1 Index: 2
,2020-03-03 13:19:30.857 Detail, Node006, Notification: ValueAdded CC: COMMAND_CLASS_CONFIGURATION Instance: 1 Index: 1
,2020-03-03 13:19:30.858 Detail, Node006, Notification: ValueAdded CC: COMMAND_CLASS_CONFIGURATION Instance: 1 Index: 2
,2020-03-03 13:19:30.858 Detail, Node006, Notification: ValueAdded CC: COMMAND_CLASS_CONFIGURATION Instance: 1 Index: 3
,  z2m:Zwave Scanning network with homeid: 0xf7148d95 +194ms
,2020-03-03 13:19:30.858 Detail, Node006, Notification: ValueAdded CC: COMMAND_CLASS_NOTIFICATION Instance: 1 Index: 6
,2020-03-03 13:19:30.858 Detail, Node006, Notification: ValueAdded CC: COMMAND_CLASS_NOTIFICATION Instance: 1 Index: 7
,2020-03-03 13:19:30.858 Detail, Node006, Notification: ValueAdded CC: COMMAND_CLASS_NOTIFICATION Instance: 1 Index: 256
,2020-03-03 13:19:30.858 Detail, Node006, Notification: ValueAdded CC: COMMAND_CLASS_MANUFACTURER_SPECIFIC Instance: 1 Index: 0
,2020-03-03 13:19:30.858 Detail, Node006, Notification: ValueAdded CC: COMMAND_CLASS_MANUFACTURER_SPECIFIC Instance: 1 Index: 1
,2020-03-03 13:19:30.858 Detail, Node006, Notification: ValueAdded CC: COMMAND_CLASS_MANUFACTURER_SPECIFIC Instance: 1 Index: 2
,2020-03-03 13:19:30.858 Detail, Node006, Notification: ValueAdded CC: COMMAND_CLASS_MANUFACTURER_SPECIFIC Instance: 1 Index: 3
,2020-03-03 13:19:30.858 Detail, Node006, Notification: ValueAdded CC: COMMAND_CLASS_MANUFACTURER_SPECIFIC Instance: 1 Index: 4
,2020-03-03 13:19:30.858 Detail, Node006, Notification: ValueAdded CC: COMMAND_CLASS_POWERLEVEL Instance: 1 Index: 0
,2020-03-03 13:19:30.859 Detail, Node006, Notification: ValueAdded CC: COMMAND_CLASS_POWERLEVEL Instance: 1 Index: 1
,2020-03-03 13:19:30.859 Detail, Node006, Notification: ValueAdded CC: COMMAND_CLASS_POWERLEVEL Instance: 1 Index: 2
,2020-03-03 13:19:30.859 Detail, Node006, Notification: ValueAdded CC: COMMAND_CLASS_POWERLEVEL Instance: 1 Index: 3
,2020-03-03 13:19:30.859 Detail, Node006, Notification: ValueAdded CC: COMMAND_CLASS_POWERLEVEL Instance: 1 Index: 4
,2020-03-03 13:19:30.859 Detail, Node006, Notification: ValueAdded CC: COMMAND_CLASS_POWERLEVEL Instance: 1 Index: 5
,2020-03-03 13:19:30.859 Detail, Node006, Notification: ValueAdded CC: COMMAND_CLASS_POWERLEVEL Instance: 1 Index: 6
,2020-03-03 13:19:30.859 Detail, Node006, Notification: ValueAdded CC: COMMAND_CLASS_POWERLEVEL Instance: 1 Index: 7
,2020-03-03 13:19:30.859 Detail, Node006, Notification: ValueAdded CC: COMMAND_CLASS_POWERLEVEL Instance: 1 Index: 8
,2020-03-03 13:19:30.859 Detail, Node006, Notification: ValueAdded CC: COMMAND_CLASS_POWERLEVEL Instance: 1 Index: 9
,2020-03-03 13:19:30.859 Detail, Node006, Notification: ValueAdded CC: COMMAND_CLASS_BATTERY Instance: 1 Index: 0
,2020-03-03 13:19:30.859 Detail, Node006, Notification: ValueAdded CC: COMMAND_CLASS_WAKE_UP Instance: 1 Index: 0
,2020-03-03 13:19:30.860 Detail, Node006, Notification: ValueAdded CC: COMMAND_CLASS_WAKE_UP Instance: 1 Index: 1
,2020-03-03 13:19:30.860 Detail, Node006, Notification: ValueAdded CC: COMMAND_CLASS_WAKE_UP Instance: 1 Index: 2
,2020-03-03 13:19:30.860 Detail, Node006, Notification: ValueAdded CC: COMMAND_CLASS_WAKE_UP Instance: 1 Index: 3
,2020-03-03 13:19:30.860 Detail, Node006, Notification: ValueAdded CC: COMMAND_CLASS_WAKE_UP Instance: 1 Index: 4
,2020-03-03 13:19:30.860 Detail, Node006, Notification: Group
,2020-03-03 13:19:30.860 Detail, Node006, Notification: Group
,2020-03-03 13:19:30.860 Detail, Node006, Notification: ValueAdded CC: COMMAND_CLASS_VERSION Instance: 1 Index: 0
,2020-03-03 13:19:30.860 Detail, Node006, Notification: ValueAdded CC: COMMAND_CLASS_VERSION Instance: 1 Index: 1
,2020-03-03 13:19:30.860 Detail, Node006, Notification: ValueAdded CC: COMMAND_CLASS_VERSION Instance: 1 Index: 2
,2020-03-03 13:19:30.860 Detail, Node006, Notification: NodeNaming
,2020-03-03 13:19:30.860 Detail, Node004, Notification: NodeNew
,2020-03-03 13:19:30.860 Detail, Node004, Notification: NodeAdded
,2020-03-03 13:19:30.860 Detail, Node005, Notification: NodeNew
,2020-03-03 13:19:30.860 Detail, Node005, Notification: NodeAdded
,2020-03-03 13:19:30.861 Detail, 
,2020-03-03 13:19:30.861 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x06) - FUNC_ID_SERIAL_API_SET_TIMEOUTS: 0x01, 0x05, 0x00, 0x06, 0x64, 0x0f, 0x97
,2020-03-03 13:19:30.861 Info, contrlr, Encrypted Flag is 0
,  z2m:Zwave Node added 1 +2ms
,  z2m:Zwave node 1 AVAILABLE: Z-Wave.Me - ZME_UZB1 USB Stick (Static PC Controller) +4ms
,2020-03-03 13:19:30.864 Detail, contrlr,   Received: 0x01, 0x05, 0x01, 0x06, 0x64, 0x0f, 0x96
,2020-03-03 13:19:30.864 Detail, 
,2020-03-03 13:19:30.864 Info, contrlr, Received reply to FUNC_ID_SERIAL_API_SET_TIMEOUTS
,2020-03-03 13:19:30.864 Detail, contrlr,   Expected reply was received
,2020-03-03 13:19:30.864 Detail, contrlr,   Message transaction complete
,2020-03-03 13:19:30.864 Detail, 
,2020-03-03 13:19:30.864 Detail, contrlr, Removing current message
,2020-03-03 13:19:30.865 Detail, 
,2020-03-03 13:19:30.865 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x00) - FUNC_ID_SERIAL_API_APPL_NODE_INFORMATION: 0x01, 0x08, 0x00, 0x03, 0x01, 0x02, 0x01, 0x01, 0x5e, 0xa9
,2020-03-03 13:19:30.865 Info, contrlr, Encrypted Flag is 0
,  z2m:Zwave ValueAdded: 1-32-1-0 Basic +2ms
,2020-03-03 13:19:30.867 Detail, contrlr, Removing current message
,2020-03-03 13:19:30.867 Detail, 
,2020-03-03 13:19:30.867 Info, Node001, Sending (Command) message (Callback ID=0x00, Expected Reply=0x80) - Get Routing Info (Node=1): 0x01, 0x07, 0x00, 0x80, 0x01, 0x00, 0x00, 0x03, 0x7a
,2020-03-03 13:19:30.867 Info, Node001, Encrypted Flag is 0
,  z2m:Zwave ValueAdded: 1-114-1-0 Loaded Config Revision +4ms
,  z2m:Zwave ValueAdded: 1-114-1-1 Config File Revision +2ms
,  z2m:Zwave ValueAdded: 1-114-1-2 Latest Available Config File Revision +2ms
,  z2m:Zwave ValueAdded: 1-114-1-3 Device ID +2ms
,2020-03-03 13:19:30.875 Detail, Node001,   Received: 0x01, 0x20, 0x01, 0x80, 0x38, 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, 0x66
,2020-03-03 13:19:30.875 Detail, 
,2020-03-03 13:19:30.875 Info, Node001, Received reply to FUNC_ID_ZW_GET_ROUTING_INFO
,2020-03-03 13:19:30.875 Info, Node001,     Neighbors of this node are:
,2020-03-03 13:19:30.875 Info, Node001,     Node 4
,2020-03-03 13:19:30.875 Info, Node001,     Node 5
,2020-03-03 13:19:30.876 Info, Node001,     Node 6
,2020-03-03 13:19:30.876 Detail, Node001,   Expected reply was received
,2020-03-03 13:19:30.876 Detail, Node001,   Message transaction complete
,2020-03-03 13:19:30.876 Detail, 
,2020-03-03 13:19:30.876 Detail, Node001, Removing current message
,2020-03-03 13:19:30.876 Detail, 
,2020-03-03 13:19:30.876 Info, Node006, Sending (NoOp) message (Callback ID=0x0a, Expected Reply=0x13) - NoOperation_Set (Node=6): 0x01, 0x09, 0x00, 0x13, 0x06, 0x02, 0x00, 0x00, 0x25, 0x0a, 0xce
,2020-03-03 13:19:30.876 Info, Node006, Encrypted Flag is 0
,  z2m:Zwave ValueAdded: 1-114-1-4 Serial Number +1ms
,  z2m:Zwave Node added 6 +1ms
,  z2m:Zwave node 6 AVAILABLE: Kaipule Technology Co. Ltd - IM20 Door/Window Sensor (Access Control Sensor) +7ms
,  z2m:Zwave ValueAdded: 6-32-1-0 Basic +0ms
,2020-03-03 13:19:30.885 Detail, Node006,   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
,2020-03-03 13:19:30.885 Detail, Node006,   ZW_SEND_DATA delivered to Z-Wave stack
,  z2m:Zwave ValueAdded: 6-48-1-0 Sensor +1ms
,  z2m:Zwave ValueAdded: 6-94-1-0 ZWave+ Version +1ms
,  z2m:Zwave ValueAdded: 6-94-1-1 InstallerIcon +1ms
,  z2m:Zwave ValueAdded: 6-94-1-2 UserIcon +0ms
,  z2m:Zwave ValueAdded: 6-112-1-1 Basic Set Level +1ms
,  z2m:Zwave ValueAdded: 6-112-1-2 Turn Off Light Time +1ms
,  z2m:Zwave ValueAdded: 6-112-1-3 Auto report status time +1ms
,  z2m:Zwave ValueAdded: 6-113-1-6 Access Control +0ms
,  z2m:Zwave ValueAdded: 6-113-1-7 Home Security +1ms
,  z2m:Zwave ValueAdded: 6-113-1-256 Previous Event Cleared +1ms
,  z2m:Zwave ValueAdded: 6-114-1-0 Loaded Config Revision +0ms
,  z2m:Zwave ValueAdded: 6-114-1-1 Config File Revision +1ms
,  z2m:Zwave ValueAdded: 6-114-1-2 Latest Available Config File Revision +0ms
,  z2m:Zwave ValueAdded: 6-114-1-3 Device ID +1ms
,  z2m:Zwave ValueAdded: 6-114-1-4 Serial Number +0ms
,  z2m:Zwave ValueAdded: 6-115-1-0 Powerlevel +1ms
,  z2m:Zwave ValueAdded: 6-115-1-1 Timeout +0ms
,  z2m:Zwave ValueAdded: 6-115-1-2 Set Powerlevel +1ms
,  z2m:Zwave ValueAdded: 6-115-1-3 Test Node +0ms
,  z2m:Zwave ValueAdded: 6-115-1-4 Test Powerlevel +1ms
,  z2m:Zwave ValueAdded: 6-115-1-5 Frame Count +0ms
,  z2m:Zwave ValueAdded: 6-115-1-6 Test +1ms
,  z2m:Zwave ValueAdded: 6-115-1-7 Report +1ms
,  z2m:Zwave ValueAdded: 6-115-1-8 Test Status +0ms
,  z2m:Zwave ValueAdded: 6-115-1-9 Acked Frames +1ms
,  z2m:Zwave ValueAdded: 6-128-1-0 Battery Level +0ms
,  z2m:Zwave ValueAdded: 6-132-1-0 Wake-up Interval +0ms
,  z2m:Zwave ValueAdded: 6-132-1-1 Minimum Wake-up Interval +1ms
,  z2m:Zwave ValueAdded: 6-132-1-2 Maximum Wake-up Interval +0ms
,  z2m:Zwave ValueAdded: 6-132-1-3 Default Wake-up Interval +1ms
,  z2m:Zwave ValueAdded: 6-132-1-4 Wake-up Interval Step +0ms
,  z2m:Zwave ValueAdded: 6-134-1-0 Library Version +0ms
,  z2m:Zwave ValueAdded: 6-134-1-1 Protocol Version +1ms
,  z2m:Zwave ValueAdded: 6-134-1-2 Application Version +0ms
,  z2m:Zwave Node added 4 +1ms
,  z2m:Zwave Node added 5 +0ms
,2020-03-03 13:19:35.266 Detail, Node006,   Received: 0x01, 0x18, 0x00, 0x13, 0x0a, 0x01, 0x01, 0xb7, 0x00, 0x7f, 0x7f, 0x7f, 0x7f, 0x7f, 0x00, 0x01, 0x07, 0x00, 0x00, 0x00, 0x00, 0x02, 0x0a, 0x00, 0x00, 0x38
,2020-03-03 13:19:35.266 Detail, Node006,   ZW_SEND_DATA Request with callback ID 0x0a received (expected 0x0a)
,2020-03-03 13:19:35.266 Detail, Node006, Extended TxStatus: Time: 4390, Hops: 0, Rssi: --- --- --- --- ---, AckChannel: 0, TxChannel: 1, RouteScheme: Explorer Route, Route: 0 0 0 0, RouteSpeed: 40K, RouteTries: 10, FailedLinkFrom: 0, FailedLinkTo: 0
,2020-03-03 13:19:35.266 Info, Node006, WARNING: ZW_SEND_DATA failed. No ACK received - device may be asleep.
,2020-03-03 13:19:35.266 Info, Node006,   Node 6 has been marked as asleep
,2020-03-03 13:19:35.266 Info, Node006, Node not responding - moving QueryStageComplete command to Wake-Up queue
,2020-03-03 13:19:35.266 Warning, CheckCompletedNodeQueries m_allNodesQueried=0 m_awakeNodesQueried=0
,2020-03-03 13:19:35.266 Warning, CheckCompletedNodeQueries all=0, deadFound=0 sleepingOnly=0
,2020-03-03 13:19:35.266 Info, Saving Cache
,2020-03-03 13:19:35.267 Info, Node001, Cache Save for Node 1 as its QueryStage_CacheLoad
,2020-03-03 13:19:35.267 Info, Node004, Skipping Cache Save for Node 4 as its not past QueryStage_CacheLoad
,2020-03-03 13:19:35.267 Info, Node005, Skipping Cache Save for Node 5 as its not past QueryStage_CacheLoad
,2020-03-03 13:19:35.268 Info, Node006, Cache Save for Node 6 as its QueryStage_CacheLoad
,2020-03-03 13:19:35.275 Detail, Node006, Notification: Notification - NoOperation
,2020-03-03 13:19:35.275 Detail, Node006, Notification: Notification - Node Asleep
,2020-03-03 13:19:35.275 Detail, Node001, Query Stage Complete (Neighbors)
,2020-03-03 13:19:35.275 Detail, Node001, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Session live=1
,2020-03-03 13:19:35.276 Detail, Node001, QueryStage_Session
,2020-03-03 13:19:35.276 Detail, Node001, QueryStage_Dynamic
,2020-03-03 13:19:35.276 Detail, Node001, QueryStage_Configuration
,2020-03-03 13:19:35.276 Detail, Node001, QueryStage_Complete
,2020-03-03 13:19:35.276 Warning, CheckCompletedNodeQueries m_allNodesQueried=0 m_awakeNodesQueried=0
,2020-03-03 13:19:35.276 Warning, CheckCompletedNodeQueries all=0, deadFound=0 sleepingOnly=0
,2020-03-03 13:19:35.276 Info, Saving Cache
,2020-03-03 13:19:35.276 Info, Node001, Cache Save for Node 1 as its QueryStage_CacheLoad
,2020-03-03 13:19:35.276 Info, Node004, Skipping Cache Save for Node 4 as its not past QueryStage_CacheLoad
,2020-03-03 13:19:35.276 Info, Node005, Skipping Cache Save for Node 5 as its not past QueryStage_CacheLoad
,2020-03-03 13:19:35.277 Info, Node006, Cache Save for Node 6 as its QueryStage_CacheLoad
,  z2m:Zwave Notification from node 6: Notification - NoOperation (2) +4s
,2020-03-03 13:19:35.285 Detail, Node001, Notification: NodeQueriesComplete
,2020-03-03 13:19:35.285 Detail, 
,2020-03-03 13:19:35.285 Info, Node004, Sending (Query) message (Callback ID=0x00, Expected Reply=0x41) - Get Node Protocol Info (Node=4): 0x01, 0x04, 0x00, 0x41, 0x04, 0xbe
,2020-03-03 13:19:35.285 Info, Node004, Encrypted Flag is 0
,2020-03-03 13:19:35.288 Detail, Node004,   Received: 0x01, 0x09, 0x01, 0x41, 0x53, 0x9c, 0x01, 0x04, 0x07, 0x01, 0x7a
,2020-03-03 13:19:35.288 Detail, 
,2020-03-03 13:19:35.288 Info, Node004, Received reply to FUNC_ID_ZW_GET_NODE_PROTOCOL_INFO
,2020-03-03 13:19:35.288 Info, Node004,   Protocol Info for Node 4:
,2020-03-03 13:19:35.288 Info, Node004,     Listening     = false
,2020-03-03 13:19:35.288 Info, Node004,     Frequent      = false
,2020-03-03 13:19:35.288 Info, Node004,     Beaming       = true
,2020-03-03 13:19:35.288 Info, Node004,     Routing       = true
,2020-03-03 13:19:35.288 Info, Node004,     Max Baud Rate = 100000
,2020-03-03 13:19:35.288 Info, Node004,     Version       = 4
,2020-03-03 13:19:35.289 Info, Node004,     Security      = false
,2020-03-03 13:19:35.289 Info, Node004,   Basic device class    (0x04) - Routing Slave
,2020-03-03 13:19:35.289 Info, Node004,   Generic device Class  (0x07) - Notification Sensor
,2020-03-03 13:19:35.289 Info, Node004,   Specific device class (0x01) - Notification Sensor
,2020-03-03 13:19:35.289 Info, Node004,   Mandatory Command Classes for Node 4:
,2020-03-03 13:19:35.289 Info, Node004,     COMMAND_CLASS_BASIC
,2020-03-03 13:19:35.289 Info, Node004,     COMMAND_CLASS_MANUFACTURER_SPECIFIC
,2020-03-03 13:19:35.289 Info, Node004,     COMMAND_CLASS_WAKE_UP
,2020-03-03 13:19:35.289 Info, Node004,   Mandatory Command Classes controlled by Node 4:
,2020-03-03 13:19:35.289 Info, Node004,     None
,2020-03-03 13:19:35.289 Detail, Node004,   Expected reply was received
,2020-03-03 13:19:35.289 Detail, Node004,   Message transaction complete
,2020-03-03 13:19:35.289 Detail, 
,2020-03-03 13:19:35.289 Detail, Node004, Removing current message
,2020-03-03 13:19:35.290 Detail, Node004, Notification: NodeProtocolInfo
,2020-03-03 13:19:35.290 Detail, Node004, Query Stage Complete (ProtocolInfo)
,2020-03-03 13:19:35.290 Detail, Node004, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Probe live=1
,2020-03-03 13:19:35.290 Detail, Node004, QueryStage_Probe
,2020-03-03 13:19:35.290 Info, Node004, NoOperation::Set - Routing=true
,2020-03-03 13:19:35.290 Detail, Node004, Queuing (NoOp) NoOperation_Set (Node=4): 0x01, 0x09, 0x00, 0x13, 0x04, 0x02, 0x00, 0x00, 0x25, 0x0b, 0xcd
,2020-03-03 13:19:35.290 Detail, Node004, Queuing (Query) Query Stage Complete (Probe)
,2020-03-03 13:19:35.290 Detail, 
,2020-03-03 13:19:35.290 Info, Node004, Sending (NoOp) message (Callback ID=0x0b, Expected Reply=0x13) - NoOperation_Set (Node=4): 0x01, 0x09, 0x00, 0x13, 0x04, 0x02, 0x00, 0x00, 0x25, 0x0b, 0xcd
,2020-03-03 13:19:35.290 Info, Node004, Encrypted Flag is 0
,  z2m:Zwave Notification from node 6: Notification - Node Asleep (4) +12ms
,  z2m:Zwave node 1 ready: Z-Wave.Me - ZME_UZB1 USB Stick (Static PC Controller) +6ms
,2020-03-03 13:19:35.301 Detail, Node004,   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
,2020-03-03 13:19:35.301 Detail, Node004,   ZW_SEND_DATA delivered to Z-Wave stack
,2020-03-03 13:19:39.574 Detail, Node004,   Received: 0x01, 0x18, 0x00, 0x13, 0x0b, 0x01, 0x01, 0xab, 0x00, 0x7f, 0x7f, 0x7f, 0x7f, 0x7f, 0x00, 0x01, 0x07, 0x00, 0x00, 0x00, 0x00, 0x02, 0x07, 0x00, 0x00, 0x28
,2020-03-03 13:19:39.574 Detail, Node004,   ZW_SEND_DATA Request with callback ID 0x0b received (expected 0x0b)
,2020-03-03 13:19:39.574 Detail, Node004, Extended TxStatus: Time: 4270, Hops: 0, Rssi: --- --- --- --- ---, AckChannel: 0, TxChannel: 1, RouteScheme: Explorer Route, Route: 0 0 0 0, RouteSpeed: 40K, RouteTries: 7, FailedLinkFrom: 0, FailedLinkTo: 0
,2020-03-03 13:19:39.574 Info, Node004, WARNING: ZW_SEND_DATA failed. No ACK received - device may be asleep.
,2020-03-03 13:19:39.575 Info, Node004,   Node 4 has been marked as asleep
,2020-03-03 13:19:39.575 Info, Node004, Node not responding - moving QueryStageComplete command to Wake-Up queue
,2020-03-03 13:19:39.575 Warning, CheckCompletedNodeQueries m_allNodesQueried=0 m_awakeNodesQueried=0
,2020-03-03 13:19:39.575 Warning, CheckCompletedNodeQueries all=0, deadFound=0 sleepingOnly=0
,2020-03-03 13:19:39.575 Info, Saving Cache
,2020-03-03 13:19:39.575 Info, Node001, Cache Save for Node 1 as its QueryStage_CacheLoad
,2020-03-03 13:19:39.576 Info, Node004, Skipping Cache Save for Node 4 as its not past QueryStage_CacheLoad
,2020-03-03 13:19:39.576 Info, Node005, Skipping Cache Save for Node 5 as its not past QueryStage_CacheLoad
,2020-03-03 13:19:39.577 Info, Node006, Cache Save for Node 6 as its QueryStage_CacheLoad
,2020-03-03 13:19:39.584 Detail, Node004, Notification: Notification - NoOperation
,2020-03-03 13:19:39.584 Detail, Node004, Notification: Notification - Node Asleep
,2020-03-03 13:19:39.584 Detail, 
,2020-03-03 13:19:39.584 Info, Node005, Sending (Query) message (Callback ID=0x00, Expected Reply=0x41) - Get Node Protocol Info (Node=5): 0x01, 0x04, 0x00, 0x41, 0x05, 0xbf
,2020-03-03 13:19:39.584 Info, Node005, Encrypted Flag is 0
,  z2m:Zwave Notification from node 4: Notification - NoOperation (2) +4s
,  z2m:Zwave Notification from node 4: Notification - Node Asleep (4) +2ms
,2020-03-03 13:19:39.587 Detail, Node005,   Received: 0x01, 0x09, 0x01, 0x41, 0x53, 0x9c, 0x01, 0x04, 0x07, 0x01, 0x7a
,2020-03-03 13:19:39.587 Detail, 
,2020-03-03 13:19:39.587 Info, Node005, Received reply to FUNC_ID_ZW_GET_NODE_PROTOCOL_INFO
,2020-03-03 13:19:39.587 Info, Node005,   Protocol Info for Node 5:
,2020-03-03 13:19:39.587 Info, Node005,     Listening     = false
,2020-03-03 13:19:39.587 Info, Node005,     Frequent      = false
,2020-03-03 13:19:39.587 Info, Node005,     Beaming       = true
,2020-03-03 13:19:39.587 Info, Node005,     Routing       = true
,2020-03-03 13:19:39.587 Info, Node005,     Max Baud Rate = 100000
,2020-03-03 13:19:39.587 Info, Node005,     Version       = 4
,2020-03-03 13:19:39.587 Info, Node005,     Security      = false
,2020-03-03 13:19:39.587 Info, Node005,   Basic device class    (0x04) - Routing Slave
,2020-03-03 13:19:39.587 Info, Node005,   Generic device Class  (0x07) - Notification Sensor
,2020-03-03 13:19:39.588 Info, Node005,   Specific device class (0x01) - Notification Sensor
,2020-03-03 13:19:39.588 Info, Node005,   Mandatory Command Classes for Node 5:
,2020-03-03 13:19:39.588 Info, Node005,     COMMAND_CLASS_BASIC
,2020-03-03 13:19:39.588 Info, Node005,     COMMAND_CLASS_MANUFACTURER_SPECIFIC
,2020-03-03 13:19:39.588 Info, Node005,     COMMAND_CLASS_WAKE_UP
,2020-03-03 13:19:39.588 Info, Node005,   Mandatory Command Classes controlled by Node 5:
,2020-03-03 13:19:39.588 Info, Node005,     None
,2020-03-03 13:19:39.588 Detail, Node005,   Expected reply was received
,2020-03-03 13:19:39.588 Detail, Node005,   Message transaction complete
,2020-03-03 13:19:39.588 Detail, 
,2020-03-03 13:19:39.588 Detail, Node005, Removing current message
,2020-03-03 13:19:39.588 Detail, Node005, Notification: NodeProtocolInfo
,2020-03-03 13:19:39.588 Detail, Node005, Query Stage Complete (ProtocolInfo)
,2020-03-03 13:19:39.588 Detail, Node005, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Probe live=1
,2020-03-03 13:19:39.588 Detail, Node005, QueryStage_Probe
,2020-03-03 13:19:39.588 Info, Node005, NoOperation::Set - Routing=true
,2020-03-03 13:19:39.589 Detail, Node005, Queuing (NoOp) NoOperation_Set (Node=5): 0x01, 0x09, 0x00, 0x13, 0x05, 0x02, 0x00, 0x00, 0x25, 0x0c, 0xcb
,2020-03-03 13:19:39.589 Detail, Node005, Queuing (Query) Query Stage Complete (Probe)
,2020-03-03 13:19:39.589 Detail, 
,2020-03-03 13:19:39.589 Info, Node005, Sending (NoOp) message (Callback ID=0x0c, Expected Reply=0x13) - NoOperation_Set (Node=5): 0x01, 0x09, 0x00, 0x13, 0x05, 0x02, 0x00, 0x00, 0x25, 0x0c, 0xcb
,2020-03-03 13:19:39.589 Info, Node005, Encrypted Flag is 0
,2020-03-03 13:19:39.599 Detail, Node005,   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
,2020-03-03 13:19:39.600 Detail, Node005,   ZW_SEND_DATA delivered to Z-Wave stack
,2020-03-03 13:19:43.872 Detail, Node005,   Received: 0x01, 0x18, 0x00, 0x13, 0x0c, 0x01, 0x01, 0xab, 0x00, 0x7f, 0x7f, 0x7f, 0x7f, 0x7f, 0x00, 0x01, 0x07, 0x00, 0x00, 0x00, 0x00, 0x02, 0x07, 0x00, 0x00, 0x2f
,2020-03-03 13:19:43.872 Detail, Node005,   ZW_SEND_DATA Request with callback ID 0x0c received (expected 0x0c)
,2020-03-03 13:19:43.872 Detail, Node005, Extended TxStatus: Time: 4270, Hops: 0, Rssi: --- --- --- --- ---, AckChannel: 0, TxChannel: 1, RouteScheme: Explorer Route, Route: 0 0 0 0, RouteSpeed: 40K, RouteTries: 7, FailedLinkFrom: 0, FailedLinkTo: 0
,2020-03-03 13:19:43.873 Info, Node005, WARNING: ZW_SEND_DATA failed. No ACK received - device may be asleep.
,2020-03-03 13:19:43.873 Info, Node005,   Node 5 has been marked as asleep
,2020-03-03 13:19:43.873 Info, Node005, Node not responding - moving QueryStageComplete command to Wake-Up queue
,2020-03-03 13:19:43.873 Warning, CheckCompletedNodeQueries m_allNodesQueried=0 m_awakeNodesQueried=0
,2020-03-03 13:19:43.873 Warning, CheckCompletedNodeQueries all=0, deadFound=0 sleepingOnly=1
,2020-03-03 13:19:43.873 Info,          Node query processing complete except for sleeping nodes.
,2020-03-03 13:19:43.873 Info, Saving Cache
,2020-03-03 13:19:43.873 Info, Node001, Cache Save for Node 1 as its QueryStage_CacheLoad
,2020-03-03 13:19:43.874 Info, Node004, Skipping Cache Save for Node 4 as its not past QueryStage_CacheLoad
,2020-03-03 13:19:43.874 Info, Node005, Skipping Cache Save for Node 5 as its not past QueryStage_CacheLoad
,2020-03-03 13:19:43.875 Info, Node006, Cache Save for Node 6 as its QueryStage_CacheLoad
,2020-03-03 13:19:43.878 Detail, Node005, Notification: Notification - NoOperation
,2020-03-03 13:19:43.878 Detail, Node005, Notification: Notification - Node Asleep
,2020-03-03 13:19:43.878 Detail, contrlr, Notification: AwakeNodesQueried
,  z2m:Zwave Notification from node 5: Notification - NoOperation (2) +4s
,  z2m:Zwave Notification from node 5: Notification - Node Asleep (4) +0ms
,2020-03-03 13:19:43.879 Detail, Node001, Reloading Node
,2020-03-03 13:19:43.882 Detail, Node001, Notification: ValueRemoved CC: COMMAND_CLASS_BASIC Instance: 1 Index: 0
,2020-03-03 13:19:43.882 Detail, Node001, Notification: ValueRemoved CC: COMMAND_CLASS_MANUFACTURER_SPECIFIC Instance: 1 Index: 0
,2020-03-03 13:19:43.882 Info, Saving Cache
,2020-03-03 13:19:43.882 Info, Node004, Skipping Cache Save for Node 4 as its not past QueryStage_CacheLoad
,2020-03-03 13:19:43.882 Info, Node005, Skipping Cache Save for Node 5 as its not past QueryStage_CacheLoad
,2020-03-03 13:19:43.882 Detail, Node001, Notification: ValueRemoved CC: COMMAND_CLASS_MANUFACTURER_SPECIFIC Instance: 1 Index: 1
,2020-03-03 13:19:43.882 Detail, Node001, Notification: ValueRemoved CC: COMMAND_CLASS_MANUFACTURER_SPECIFIC Instance: 1 Index: 2
,2020-03-03 13:19:43.882 Detail, Node001, Notification: ValueRemoved CC: COMMAND_CLASS_MANUFACTURER_SPECIFIC Instance: 1 Index: 3
,2020-03-03 13:19:43.882 Detail, Node001, Notification: ValueRemoved CC: COMMAND_CLASS_MANUFACTURER_SPECIFIC Instance: 1 Index: 4
,2020-03-03 13:19:43.882 Info, Node006, Cache Save for Node 6 as its QueryStage_CacheLoad
,2020-03-03 13:19:43.883 Detail, Node001, AdvanceQueries queryPending=0 queryRetries=0 queryStage=None live=1
,2020-03-03 13:19:43.883 Detail, Node001, Notification: NodeRemoved
,2020-03-03 13:19:43.884 Detail, Node001, Notification: NodeAdded
,2020-03-03 13:19:43.884 Detail, Node001, QueryStage_ProtocolInfo
,2020-03-03 13:19:43.884 Detail, Node001, Queuing (Query) Get Node Protocol Info (Node=1): 0x01, 0x04, 0x00, 0x41, 0x01, 0xbb
,2020-03-03 13:19:43.884 Detail, Node001, Queuing (Query) Query Stage Complete (ProtocolInfo)
,2020-03-03 13:19:43.884 Info, Node001, Initializing Node. New Node: false (false)
,2020-03-03 13:19:43.884 Detail, 
,2020-03-03 13:19:43.884 Info, Node001, Sending (Query) message (Callback ID=0x00, Expected Reply=0x41) - Get Node Protocol Info (Node=1): 0x01, 0x04, 0x00, 0x41, 0x01, 0xbb
,2020-03-03 13:19:43.884 Info, Node001, Encrypted Flag is 0
,2020-03-03 13:19:43.884 Detail, Node004, Reloading Node
,2020-03-03 13:19:43.886 Info, Saving Cache
,2020-03-03 13:19:43.886 Info, Node001, Skipping Cache Save for Node 1 as its not past QueryStage_CacheLoad
,2020-03-03 13:19:43.886 Info, Node005, Skipping Cache Save for Node 5 as its not past QueryStage_CacheLoad
,2020-03-03 13:19:43.886 Detail, Node001,   Received: 0x01, 0x09, 0x01, 0x41, 0xd3, 0x16, 0x01, 0x02, 0x02, 0x01, 0x73
,2020-03-03 13:19:43.886 Detail, 
,2020-03-03 13:19:43.886 Info, Node001, Received reply to FUNC_ID_ZW_GET_NODE_PROTOCOL_INFO
,2020-03-03 13:19:43.886 Info, Node001,   Protocol Info for Node 1:
,2020-03-03 13:19:43.886 Info, Node001,     Listening     = true
,2020-03-03 13:19:43.886 Info, Node001,     Beaming       = true
,2020-03-03 13:19:43.886 Info, Node001,     Routing       = true
,2020-03-03 13:19:43.886 Info, Node001,     Max Baud Rate = 100000
,2020-03-03 13:19:43.886 Info, Node001,     Version       = 4
,2020-03-03 13:19:43.886 Info, Node001,     Security      = false
,2020-03-03 13:19:43.887 Info, Node001,   Basic device class    (0x02) - Static Controller
,2020-03-03 13:19:43.887 Info, Node001,   Generic device Class  (0x02) - Static Controller
,2020-03-03 13:19:43.887 Info, Node006, Cache Save for Node 6 as its QueryStage_CacheLoad
,2020-03-03 13:19:43.887 Info, Node001,   Specific device class (0x01) - Static PC Controller
,2020-03-03 13:19:43.887 Info, Node001,   Mandatory Command Classes for Node 1:
,2020-03-03 13:19:43.887 Info, Node001,     COMMAND_CLASS_MANUFACTURER_SPECIFIC
,2020-03-03 13:19:43.887 Info, Node001,   Mandatory Command Classes controlled by Node 1:
,2020-03-03 13:19:43.887 Info, Node001,     COMMAND_CLASS_BASIC
,2020-03-03 13:19:43.887 Detail, Node001,   Expected reply was received
,2020-03-03 13:19:43.887 Detail, Node001,   Message transaction complete
,2020-03-03 13:19:43.887 Detail, 
,2020-03-03 13:19:43.887 Detail, Node001, Removing current message
,2020-03-03 13:19:43.887 Detail, Node001, Notification: NodeProtocolInfo
,2020-03-03 13:19:43.887 Detail, Node001, Query Stage Complete (ProtocolInfo)
,2020-03-03 13:19:43.887 Detail, Node001, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Probe live=1
,2020-03-03 13:19:43.887 Detail, Node001, QueryStage_Probe
,2020-03-03 13:19:43.887 Detail, Node001, QueryStage_WakeUp
,2020-03-03 13:19:43.887 Info, Node001, NodeInfo Stage - NodeInfoRecieved 0 - NotInfoSupported 1
,2020-03-03 13:19:43.887 Detail, Node001, QueryStage_NodePlusInfo
,2020-03-03 13:19:43.887 Detail, Node001, QueryStage_SecurityReport
,2020-03-03 13:19:43.887 Detail, Node001, QueryStage_Versions
,2020-03-03 13:19:43.887 Detail, Node001, QueryStage_ManufacturerSpecific1
,2020-03-03 13:19:43.887 Detail, Node001, Load Controller Manufacturer Specific Config
,2020-03-03 13:19:43.887 Detail, Node001, QueryStage_Instances
,2020-03-03 13:19:43.887 Info, Node001, Essential node queries are complete
,2020-03-03 13:19:43.887 Detail, Node001, QueryStage_ManufacturerSpecific2
,2020-03-03 13:19:43.887 Detail, Node001, QueryStage_Static
,2020-03-03 13:19:43.887 Info, Node001, Creating ValueIDs for Instance 1 on COMMAND_CLASS_BASIC
,2020-03-03 13:19:43.887 Info, Node001, COMMAND_CLASS_BASIC is not mapped to another CC. Exposing ValueID
,2020-03-03 13:19:43.887 Info, Node001, Creating ValueIDs for Instance 1 on COMMAND_CLASS_MANUFACTURER_SPECIFIC
,2020-03-03 13:19:43.887 Detail, Node001, QueryStage_Associations
,2020-03-03 13:19:43.887 Detail, Node001, QueryStage_Neighbors
,2020-03-03 13:19:43.887 Detail, Requesting routing info (neighbor list) for Node 1
,2020-03-03 13:19:43.888 Detail, Node004, AdvanceQueries queryPending=0 queryRetries=0 queryStage=None live=1
,2020-03-03 13:19:43.888 Detail, Node004, QueryStage_ProtocolInfo
,2020-03-03 13:19:43.888 Detail, Node004, Queuing (Query) Get Node Protocol Info (Node=4): 0x01, 0x04, 0x00, 0x41, 0x04, 0xbe
,2020-03-03 13:19:43.888 Detail, Node004, Queuing (Query) Query Stage Complete (ProtocolInfo)
,2020-03-03 13:19:43.888 Info, Node004, Initializing Node. New Node: false (false)
,2020-03-03 13:19:43.888 Detail, Node005, Reloading Node
,2020-03-03 13:19:43.890 Info, Saving Cache
,2020-03-03 13:19:43.891 Info, Node001, Cache Save for Node 1 as its QueryStage_CacheLoad
,2020-03-03 13:19:43.891 Info, Node004, Skipping Cache Save for Node 4 as its not past QueryStage_CacheLoad
,2020-03-03 13:19:43.891 Info, Node006, Cache Save for Node 6 as its QueryStage_CacheLoad
,2020-03-03 13:19:43.893 Detail, Node005, AdvanceQueries queryPending=0 queryRetries=0 queryStage=None live=1
,2020-03-03 13:19:43.893 Detail, Node005, QueryStage_ProtocolInfo
,2020-03-03 13:19:43.893 Detail, Node005, Queuing (Query) Get Node Protocol Info (Node=5): 0x01, 0x04, 0x00, 0x41, 0x05, 0xbf
,2020-03-03 13:19:43.893 Detail, Node005, Queuing (Query) Query Stage Complete (ProtocolInfo)
,2020-03-03 13:19:43.893 Info, Node005, Initializing Node. New Node: false (false)
,2020-03-03 13:19:43.893 Detail, Node001, Queuing (Command) Get Routing Info (Node=1): 0x01, 0x07, 0x00, 0x80, 0x01, 0x00, 0x00, 0x03, 0x7a
,2020-03-03 13:19:43.893 Detail, Node006, Reloading Node
,2020-03-03 13:19:43.895 Info, Saving Cache
,2020-03-03 13:19:43.895 Info, Node001, Cache Save for Node 1 as its QueryStage_CacheLoad
,2020-03-03 13:19:43.895 Info, Node004, Skipping Cache Save for Node 4 as its not past QueryStage_CacheLoad
,2020-03-03 13:19:43.895 Info, Node005, Skipping Cache Save for Node 5 as its not past QueryStage_CacheLoad
,2020-03-03 13:19:43.895 Detail, Node006, AdvanceQueries queryPending=0 queryRetries=0 queryStage=None live=1
,2020-03-03 13:19:43.895 Detail, Node006, QueryStage_ProtocolInfo
,2020-03-03 13:19:43.895 Detail, Node006, Queuing (Query) Get Node Protocol Info (Node=6): 0x01, 0x04, 0x00, 0x41, 0x06, 0xbc
,2020-03-03 13:19:43.895 Detail, Node006, Queuing (Query) Query Stage Complete (ProtocolInfo)
,2020-03-03 13:19:43.895 Info, Node006, Initializing Node. New Node: false (false)
,2020-03-03 13:19:43.895 Detail, Node001, Queuing (Query) Query Stage Complete (Neighbors)
,2020-03-03 13:19:43.895 Detail, Node001, Notification: EssentialNodeQueriesComplete
,2020-03-03 13:19:43.895 Detail, Node001, Notification: ValueAdded CC: COMMAND_CLASS_BASIC Instance: 1 Index: 0
,2020-03-03 13:19:43.895 Detail, Node001, Notification: ValueAdded CC: COMMAND_CLASS_MANUFACTURER_SPECIFIC Instance: 1 Index: 0
,2020-03-03 13:19:43.895 Detail, Node001, Notification: ValueAdded CC: COMMAND_CLASS_MANUFACTURER_SPECIFIC Instance: 1 Index: 1
,2020-03-03 13:19:43.895 Detail, Node001, Notification: ValueAdded CC: COMMAND_CLASS_MANUFACTURER_SPECIFIC Instance: 1 Index: 2
,2020-03-03 13:19:43.895 Detail, Node001, Notification: ValueAdded CC: COMMAND_CLASS_MANUFACTURER_SPECIFIC Instance: 1 Index: 3
,2020-03-03 13:19:43.895 Detail, Node001, Notification: ValueAdded CC: COMMAND_CLASS_MANUFACTURER_SPECIFIC Instance: 1 Index: 4
,2020-03-03 13:19:43.895 Detail, Node004, Notification: NodeRemoved
,2020-03-03 13:19:43.895 Detail, Node004, Notification: NodeAdded
,2020-03-03 13:19:43.895 Detail, Node005, Notification: NodeRemoved
,2020-03-03 13:19:43.895 Detail, Node005, Notification: NodeAdded
,2020-03-03 13:19:43.895 Detail, Node006, Notification: ValueRemoved CC: COMMAND_CLASS_BASIC Instance: 1 Index: 0
,2020-03-03 13:19:43.895 Detail, Node006, Notification: ValueRemoved CC: COMMAND_CLASS_SENSOR_BINARY Instance: 1 Index: 0
,2020-03-03 13:19:43.895 Detail, Node006, Notification: ValueRemoved CC: COMMAND_CLASS_ZWAVEPLUS_INFO Instance: 1 Index: 0
,2020-03-03 13:19:43.895 Detail, Node006, Notification: ValueRemoved CC: COMMAND_CLASS_MANUFACTURER_SPECIFIC Instance: 1 Index: 0
,  z2m:Zwave Network scan complete. Found: 4 nodes +16ms
,2020-03-03 13:19:43.895 Detail, Node006, Notification: ValueRemoved CC: COMMAND_CLASS_POWERLEVEL Instance: 1 Index: 0
,2020-03-03 13:19:43.895 Detail, Node006, Notification: ValueRemoved CC: COMMAND_CLASS_BATTERY Instance: 1 Index: 0
,2020-03-03 13:19:43.895 Detail, Node006, Notification: ValueRemoved CC: COMMAND_CLASS_WAKE_UP Instance: 1 Index: 0
,2020-03-03 13:19:43.895 Detail, Node006, Notification: ValueRemoved CC: COMMAND_CLASS_VERSION Instance: 1 Index: 0
,2020-03-03 13:19:43.895 Detail, Node006, Notification: ValueRemoved CC: COMMAND_CLASS_ZWAVEPLUS_INFO Instance: 1 Index: 1
,2020-03-03 13:19:43.895 Detail, Node006, Notification: ValueRemoved CC: COMMAND_CLASS_CONFIGURATION Instance: 1 Index: 1
,2020-03-03 13:19:43.895 Detail, Node006, Notification: ValueRemoved CC: COMMAND_CLASS_MANUFACTURER_SPECIFIC Instance: 1 Index: 1
,2020-03-03 13:19:43.895 Detail, Node006, Notification: ValueRemoved CC: COMMAND_CLASS_POWERLEVEL Instance: 1 Index: 1
,2020-03-03 13:19:43.895 Detail, Node006, Notification: ValueRemoved CC: COMMAND_CLASS_WAKE_UP Instance: 1 Index: 1
,2020-03-03 13:19:43.896 Detail, Node006, Notification: ValueRemoved CC: COMMAND_CLASS_VERSION Instance: 1 Index: 1
,2020-03-03 13:19:43.896 Detail, Node006, Notification: ValueRemoved CC: COMMAND_CLASS_ZWAVEPLUS_INFO Instance: 1 Index: 2
,2020-03-03 13:19:43.896 Detail, Node006, Notification: ValueRemoved CC: COMMAND_CLASS_CONFIGURATION Instance: 1 Index: 2
,2020-03-03 13:19:43.896 Detail, Node006, Notification: ValueRemoved CC: COMMAND_CLASS_MANUFACTURER_SPECIFIC Instance: 1 Index: 2
,2020-03-03 13:19:43.896 Detail, Node006, Notification: ValueRemoved CC: COMMAND_CLASS_POWERLEVEL Instance: 1 Index: 2
,2020-03-03 13:19:43.896 Detail, Node006, Notification: ValueRemoved CC: COMMAND_CLASS_WAKE_UP Instance: 1 Index: 2
,2020-03-03 13:19:43.896 Detail, Node006, Notification: ValueRemoved CC: COMMAND_CLASS_VERSION Instance: 1 Index: 2
,2020-03-03 13:19:43.896 Detail, Node006, Notification: ValueRemoved CC: COMMAND_CLASS_CONFIGURATION Instance: 1 Index: 3
,2020-03-03 13:19:43.896 Detail, Node006, Notification: ValueRemoved CC: COMMAND_CLASS_MANUFACTURER_SPECIFIC Instance: 1 Index: 3
,2020-03-03 13:19:43.896 Detail, Node006, Notification: ValueRemoved CC: COMMAND_CLASS_POWERLEVEL Instance: 1 Index: 3
,2020-03-03 13:19:43.896 Detail, Node006, Notification: ValueRemoved CC: COMMAND_CLASS_WAKE_UP Instance: 1 Index: 3
,2020-03-03 13:19:43.896 Detail, Node006, Notification: ValueRemoved CC: COMMAND_CLASS_MANUFACTURER_SPECIFIC Instance: 1 Index: 4
,2020-03-03 13:19:43.896 Detail, Node006, Notification: ValueRemoved CC: COMMAND_CLASS_POWERLEVEL Instance: 1 Index: 4
,2020-03-03 13:19:43.896 Detail, Node006, Notification: ValueRemoved CC: COMMAND_CLASS_WAKE_UP Instance: 1 Index: 4
,2020-03-03 13:19:43.896 Detail, Node006, Notification: ValueRemoved CC: COMMAND_CLASS_POWERLEVEL Instance: 1 Index: 5
,2020-03-03 13:19:43.896 Detail, Node006, Notification: ValueRemoved CC: COMMAND_CLASS_NOTIFICATION Instance: 1 Index: 6
,2020-03-03 13:19:43.896 Detail, Node006, Notification: ValueRemoved CC: COMMAND_CLASS_POWERLEVEL Instance: 1 Index: 6
,2020-03-03 13:19:43.896 Detail, Node006, Notification: ValueRemoved CC: COMMAND_CLASS_NOTIFICATION Instance: 1 Index: 7
,2020-03-03 13:19:43.896 Detail, Node006, Notification: ValueRemoved CC: COMMAND_CLASS_POWERLEVEL Instance: 1 Index: 7
,2020-03-03 13:19:43.896 Detail, Node006, Notification: ValueRemoved CC: COMMAND_CLASS_POWERLEVEL Instance: 1 Index: 8
,2020-03-03 13:19:43.896 Detail, Node006, Notification: ValueRemoved CC: COMMAND_CLASS_POWERLEVEL Instance: 1 Index: 9
,2020-03-03 13:19:43.896 Detail, Node006, Notification: ValueRemoved CC: COMMAND_CLASS_NOTIFICATION Instance: 1 Index: 256
,2020-03-03 13:19:43.896 Detail, Node006, Notification: NodeRemoved
,2020-03-03 13:19:43.896 Detail, Node006, Notification: NodeAdded
,2020-03-03 13:19:43.896 Detail, 
,2020-03-03 13:19:43.896 Info, Node001, Sending (Command) message (Callback ID=0x00, Expected Reply=0x80) - Get Routing Info (Node=1): 0x01, 0x07, 0x00, 0x80, 0x01, 0x00, 0x00, 0x03, 0x7a
,  z2m:Zwave ValueRemoved: 32-1-0 from node 1 +1ms
,2020-03-03 13:19:43.896 Info, Node001, Encrypted Flag is 0
,  z2m:Zwave ValueRemoved: 114-1-0 from node 1 +0ms
,  z2m:Zwave ValueRemoved: 114-1-1 from node 1 +0ms
,  z2m:Zwave ValueRemoved: 114-1-2 from node 1 +1ms
,  z2m:Zwave ValueRemoved: 114-1-3 from node 1 +0ms
,  z2m:Zwave ValueRemoved: 114-1-4 from node 1 +0ms
,  z2m:Zwave Node removed 1 +0ms
,  z2m:Zwave Node added 1 +1ms
,  z2m:Zwave node 1 AVAILABLE: Z-Wave.Me - ZME_UZB1 USB Stick (Static PC Controller) +0ms
,  z2m:Zwave ValueAdded: 1-32-1-0 Basic +0ms
,  z2m:Zwave ValueAdded: 1-114-1-0 Loaded Config Revision +1ms
,  z2m:Zwave ValueAdded: 1-114-1-1 Config File Revision +0ms
,  z2m:Zwave ValueAdded: 1-114-1-2 Latest Available Config File Revision +1ms
,  z2m:Zwave ValueAdded: 1-114-1-3 Device ID +0ms
,2020-03-03 13:19:43.901 Detail, Node001,   Received: 0x01, 0x20, 0x01, 0x80, 0x38, 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, 0x66
,2020-03-03 13:19:43.901 Detail, 
,2020-03-03 13:19:43.901 Info, Node001, Received reply to FUNC_ID_ZW_GET_ROUTING_INFO
,2020-03-03 13:19:43.901 Info, Node001,     Neighbors of this node are:
,2020-03-03 13:19:43.901 Info, Node001,     Node 4
,2020-03-03 13:19:43.901 Info, Node001,     Node 5
,2020-03-03 13:19:43.901 Info, Node001,     Node 6
,2020-03-03 13:19:43.901 Detail, Node001,   Expected reply was received
,2020-03-03 13:19:43.901 Detail, Node001,   Message transaction complete
,2020-03-03 13:19:43.901 Detail, 
,2020-03-03 13:19:43.901 Detail, Node001, Removing current message
,2020-03-03 13:19:43.901 Detail, 
,2020-03-03 13:19:43.901 Info, Node004, Sending (Query) message (Callback ID=0x00, Expected Reply=0x41) - Get Node Protocol Info (Node=4): 0x01, 0x04, 0x00, 0x41, 0x04, 0xbe
,2020-03-03 13:19:43.901 Info, Node004, Encrypted Flag is 0
,  z2m:Zwave ValueAdded: 1-114-1-4 Serial Number +1ms
,  z2m:Zwave Node removed 4 +0ms
,  z2m:Zwave Node added 4 +0ms
,  z2m:Zwave Node removed 5 +1ms
,  z2m:Zwave Node added 5 +0ms
,  z2m:Zwave ValueRemoved: 32-1-0 from node 6 +0ms
,  z2m:Zwave ValueRemoved: 48-1-0 from node 6 +0ms
,  z2m:Zwave ValueRemoved: 94-1-0 from node 6 +1ms
,  z2m:Zwave ValueRemoved: 114-1-0 from node 6 +0ms
,  z2m:Zwave ValueRemoved: 115-1-0 from node 6 +0ms
,  z2m:Zwave ValueRemoved: 128-1-0 from node 6 +0ms
,  z2m:Zwave ValueRemoved: 132-1-0 from node 6 +1ms
,2020-03-03 13:19:43.904 Detail, Node004,   Received: 0x01, 0x09, 0x01, 0x41, 0x53, 0x9c, 0x01, 0x04, 0x07, 0x01, 0x7a
,2020-03-03 13:19:43.904 Detail, 
,2020-03-03 13:19:43.904 Info, Node004, Received reply to FUNC_ID_ZW_GET_NODE_PROTOCOL_INFO
,2020-03-03 13:19:43.904 Info, Node004,   Protocol Info for Node 4:
,2020-03-03 13:19:43.904 Info, Node004,     Listening     = false
,2020-03-03 13:19:43.904 Info, Node004,     Frequent      = false
,2020-03-03 13:19:43.904 Info, Node004,     Beaming       = true
,2020-03-03 13:19:43.904 Info, Node004,     Routing       = true
,  z2m:Zwave ValueRemoved: 134-1-0 from node 6 +0ms
,2020-03-03 13:19:43.904 Info, Node004,     Max Baud Rate = 100000
,2020-03-03 13:19:43.904 Info, Node004,     Version       = 4
,2020-03-03 13:19:43.904 Info, Node004,     Security      = false
,2020-03-03 13:19:43.904 Info, Node004,   Basic device class    (0x04) - Routing Slave
,2020-03-03 13:19:43.904 Info, Node004,   Generic device Class  (0x07) - Notification Sensor
,2020-03-03 13:19:43.904 Info, Node004,   Specific device class (0x01) - Notification Sensor
,2020-03-03 13:19:43.904 Info, Node004,   Mandatory Command Classes for Node 4:
,2020-03-03 13:19:43.904 Info, Node004,     COMMAND_CLASS_BASIC
,2020-03-03 13:19:43.904 Info, Node004,     COMMAND_CLASS_MANUFACTURER_SPECIFIC
,2020-03-03 13:19:43.904 Info, Node004,     COMMAND_CLASS_WAKE_UP
,2020-03-03 13:19:43.904 Info, Node004,   Mandatory Command Classes controlled by Node 4:
,2020-03-03 13:19:43.904 Info, Node004,     None
,2020-03-03 13:19:43.904 Detail, Node004,   Expected reply was received
,2020-03-03 13:19:43.904 Detail, Node004,   Message transaction complete
,  z2m:Zwave ValueRemoved: 94-1-1 from node 6 +0ms
,2020-03-03 13:19:43.904 Detail, 
,2020-03-03 13:19:43.904 Detail, Node004, Removing current message
,2020-03-03 13:19:43.904 Detail, Node004, Notification: NodeProtocolInfo
,2020-03-03 13:19:43.904 Detail, Node004, Query Stage Complete (ProtocolInfo)
,2020-03-03 13:19:43.904 Detail, Node004, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Probe live=1
,2020-03-03 13:19:43.904 Detail, Node004, QueryStage_Probe
,2020-03-03 13:19:43.904 Info, Node004, NoOperation::Set - Routing=true
,2020-03-03 13:19:43.904 Detail, Node004, Queuing (NoOp) NoOperation_Set (Node=4): 0x01, 0x09, 0x00, 0x13, 0x04, 0x02, 0x00, 0x00, 0x25, 0x0d, 0xcb
,2020-03-03 13:19:43.904 Detail, Node004, Queuing (Query) Query Stage Complete (Probe)
,2020-03-03 13:19:43.904 Detail, 
,2020-03-03 13:19:43.904 Info, Node004, Sending (NoOp) message (Callback ID=0x0d, Expected Reply=0x13) - NoOperation_Set (Node=4): 0x01, 0x09, 0x00, 0x13, 0x04, 0x02, 0x00, 0x00, 0x25, 0x0d, 0xcb
,2020-03-03 13:19:43.904 Info, Node004, Encrypted Flag is 0
,  z2m:Zwave ValueRemoved: 112-1-1 from node 6 +0ms
,  z2m:Zwave ValueRemoved: 114-1-1 from node 6 +0ms
,  z2m:Zwave ValueRemoved: 115-1-1 from node 6 +1ms
,  z2m:Zwave ValueRemoved: 132-1-1 from node 6 +0ms
,  z2m:Zwave ValueRemoved: 134-1-1 from node 6 +0ms
,  z2m:Zwave ValueRemoved: 94-1-2 from node 6 +0ms
,  z2m:Zwave ValueRemoved: 112-1-2 from node 6 +0ms
,  z2m:Zwave ValueRemoved: 114-1-2 from node 6 +1ms
,  z2m:Zwave ValueRemoved: 115-1-2 from node 6 +0ms
,  z2m:Zwave ValueRemoved: 132-1-2 from node 6 +0ms
,  z2m:Zwave ValueRemoved: 134-1-2 from node 6 +0ms
,  z2m:Zwave ValueRemoved: 112-1-3 from node 6 +0ms
,  z2m:Zwave ValueRemoved: 114-1-3 from node 6 +1ms
,  z2m:Zwave ValueRemoved: 115-1-3 from node 6 +1ms
,  z2m:Zwave ValueRemoved: 132-1-3 from node 6 +0ms
,  z2m:Zwave ValueRemoved: 114-1-4 from node 6 +0ms
,  z2m:Zwave ValueRemoved: 115-1-4 from node 6 +0ms
,  z2m:Zwave ValueRemoved: 132-1-4 from node 6 +0ms
,  z2m:Zwave ValueRemoved: 115-1-5 from node 6 +1ms
,  z2m:Zwave ValueRemoved: 113-1-6 from node 6 +0ms
,  z2m:Zwave ValueRemoved: 115-1-6 from node 6 +0ms
,  z2m:Zwave ValueRemoved: 113-1-7 from node 6 +0ms
,  z2m:Zwave ValueRemoved: 115-1-7 from node 6 +0ms
,  z2m:Zwave ValueRemoved: 115-1-8 from node 6 +1ms
,  z2m:Zwave ValueRemoved: 115-1-9 from node 6 +0ms
,  z2m:Zwave ValueRemoved: 113-1-256 from node 6 +0ms
,  z2m:Zwave Node removed 6 +0ms
,  z2m:Zwave Node added 6 +0ms
,2020-03-03 13:19:43.915 Detail, Node004,   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
,2020-03-03 13:19:43.915 Detail, Node004,   ZW_SEND_DATA delivered to Z-Wave stack
,2020-03-03 13:19:48.114 Detail, Node004,   Received: 0x01, 0x18, 0x00, 0x13, 0x0d, 0x01, 0x01, 0xa5, 0x00, 0x7f, 0x7f, 0x7f, 0x7f, 0x7f, 0x00, 0x01, 0x07, 0x00, 0x00, 0x00, 0x00, 0x02, 0x07, 0x00, 0x00, 0x20
,2020-03-03 13:19:48.114 Detail, Node004,   ZW_SEND_DATA Request with callback ID 0x0d received (expected 0x0d)
,2020-03-03 13:19:48.114 Detail, Node004, Extended TxStatus: Time: 4210, Hops: 0, Rssi: --- --- --- --- ---, AckChannel: 0, TxChannel: 1, RouteScheme: Explorer Route, Route: 0 0 0 0, RouteSpeed: 40K, RouteTries: 7, FailedLinkFrom: 0, FailedLinkTo: 0
,2020-03-03 13:19:48.114 Info, Node004, WARNING: ZW_SEND_DATA failed. No ACK received - device may be asleep.
,2020-03-03 13:19:48.115 Info, Node004,   Node 4 has been marked as asleep
,2020-03-03 13:19:48.115 Info, Node004, Node not responding - moving QueryStageComplete command to Wake-Up queue
,2020-03-03 13:19:48.115 Warning, CheckCompletedNodeQueries m_allNodesQueried=0 m_awakeNodesQueried=1
,2020-03-03 13:19:48.115 Warning, CheckCompletedNodeQueries all=0, deadFound=0 sleepingOnly=0
,2020-03-03 13:19:48.115 Info, Saving Cache
,2020-03-03 13:19:48.115 Info, Node001, Cache Save for Node 1 as its QueryStage_CacheLoad
,2020-03-03 13:19:48.115 Info, Node004, Skipping Cache Save for Node 4 as its not past QueryStage_CacheLoad
,2020-03-03 13:19:48.115 Info, Node005, Skipping Cache Save for Node 5 as its not past QueryStage_CacheLoad
,2020-03-03 13:19:48.115 Info, Node006, Skipping Cache Save for Node 6 as its not past QueryStage_CacheLoad
,2020-03-03 13:19:48.117 Detail, Node004, Notification: Notification - NoOperation
,2020-03-03 13:19:48.117 Detail, Node004, Notification: Notification - Node Asleep
,2020-03-03 13:19:48.117 Detail, 
,2020-03-03 13:19:48.117 Info, Node005, Sending (Query) message (Callback ID=0x00, Expected Reply=0x41) - Get Node Protocol Info (Node=5): 0x01, 0x04, 0x00, 0x41, 0x05, 0xbf
,2020-03-03 13:19:48.117 Info, Node005, Encrypted Flag is 0
,  z2m:Zwave Notification from node 4: Notification - NoOperation (2) +4s
,2020-03-03 13:19:48.120 Detail, Node005,   Received: 0x01, 0x09, 0x01, 0x41, 0x53, 0x9c, 0x01, 0x04, 0x07, 0x01, 0x7a
,2020-03-03 13:19:48.120 Detail, 
,2020-03-03 13:19:48.120 Info, Node005, Received reply to FUNC_ID_ZW_GET_NODE_PROTOCOL_INFO
,2020-03-03 13:19:48.120 Info, Node005,   Protocol Info for Node 5:
,2020-03-03 13:19:48.120 Info, Node005,     Listening     = false
,2020-03-03 13:19:48.120 Info, Node005,     Frequent      = false
,  z2m:Zwave Notification from node 4: Notification - Node Asleep (4) +1ms
,2020-03-03 13:19:48.120 Info, Node005,     Beaming       = true
,2020-03-03 13:19:48.120 Info, Node005,     Routing       = true
,2020-03-03 13:19:48.120 Info, Node005,     Max Baud Rate = 100000
,2020-03-03 13:19:48.120 Info, Node005,     Version       = 4
,2020-03-03 13:19:48.120 Info, Node005,     Security      = false
,2020-03-03 13:19:48.120 Info, Node005,   Basic device class    (0x04) - Routing Slave
,2020-03-03 13:19:48.120 Info, Node005,   Generic device Class  (0x07) - Notification Sensor
,2020-03-03 13:19:48.120 Info, Node005,   Specific device class (0x01) - Notification Sensor
,2020-03-03 13:19:48.120 Info, Node005,   Mandatory Command Classes for Node 5:
,2020-03-03 13:19:48.120 Info, Node005,     COMMAND_CLASS_BASIC
,2020-03-03 13:19:48.120 Info, Node005,     COMMAND_CLASS_MANUFACTURER_SPECIFIC
,2020-03-03 13:19:48.120 Info, Node005,     COMMAND_CLASS_WAKE_UP
,2020-03-03 13:19:48.120 Info, Node005,   Mandatory Command Classes controlled by Node 5:
,2020-03-03 13:19:48.120 Info, Node005,     None
,2020-03-03 13:19:48.120 Detail, Node005,   Expected reply was received
,2020-03-03 13:19:48.120 Detail, Node005,   Message transaction complete
,2020-03-03 13:19:48.120 Detail, 
,2020-03-03 13:19:48.120 Detail, Node005, Removing current message
,2020-03-03 13:19:48.120 Detail, Node005, Notification: NodeProtocolInfo
,2020-03-03 13:19:48.120 Detail, Node005, Query Stage Complete (ProtocolInfo)
,2020-03-03 13:19:48.120 Detail, Node005, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Probe live=1
,2020-03-03 13:19:48.121 Detail, Node005, QueryStage_Probe
,2020-03-03 13:19:48.121 Info, Node005, NoOperation::Set - Routing=true
,2020-03-03 13:19:48.121 Detail, Node005, Queuing (NoOp) NoOperation_Set (Node=5): 0x01, 0x09, 0x00, 0x13, 0x05, 0x02, 0x00, 0x00, 0x25, 0x0e, 0xc9
,2020-03-03 13:19:48.121 Detail, Node005, Queuing (Query) Query Stage Complete (Probe)
,2020-03-03 13:19:48.121 Detail, 
,2020-03-03 13:19:48.121 Info, Node005, Sending (NoOp) message (Callback ID=0x0e, Expected Reply=0x13) - NoOperation_Set (Node=5): 0x01, 0x09, 0x00, 0x13, 0x05, 0x02, 0x00, 0x00, 0x25, 0x0e, 0xc9
,2020-03-03 13:19:48.121 Info, Node005, Encrypted Flag is 0
,2020-03-03 13:19:48.131 Detail, Node005,   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
,2020-03-03 13:19:48.132 Detail, Node005,   ZW_SEND_DATA delivered to Z-Wave stack
,2020-03-03 13:19:52.406 Detail, Node005,   Received: 0x01, 0x18, 0x00, 0x13, 0x0e, 0x01, 0x01, 0xac, 0x00, 0x7f, 0x7f, 0x7f, 0x7f, 0x7f, 0x00, 0x01, 0x07, 0x00, 0x00, 0x00, 0x00, 0x02, 0x07, 0x00, 0x00, 0x2a
,2020-03-03 13:19:52.406 Detail, Node005,   ZW_SEND_DATA Request with callback ID 0x0e received (expected 0x0e)
,2020-03-03 13:19:52.406 Detail, Node005, Extended TxStatus: Time: 4280, Hops: 0, Rssi: --- --- --- --- ---, AckChannel: 0, TxChannel: 1, RouteScheme: Explorer Route, Route: 0 0 0 0, RouteSpeed: 40K, RouteTries: 7, FailedLinkFrom: 0, FailedLinkTo: 0
,2020-03-03 13:19:52.406 Info, Node005, WARNING: ZW_SEND_DATA failed. No ACK received - device may be asleep.
,2020-03-03 13:19:52.406 Info, Node005,   Node 5 has been marked as asleep
,2020-03-03 13:19:52.406 Info, Node005, Node not responding - moving QueryStageComplete command to Wake-Up queue
,2020-03-03 13:19:52.407 Warning, CheckCompletedNodeQueries m_allNodesQueried=0 m_awakeNodesQueried=1
,2020-03-03 13:19:52.407 Warning, CheckCompletedNodeQueries all=0, deadFound=0 sleepingOnly=0
,2020-03-03 13:19:52.407 Info, Saving Cache
,2020-03-03 13:19:52.407 Info, Node001, Cache Save for Node 1 as its QueryStage_CacheLoad
,2020-03-03 13:19:52.407 Info, Node004, Skipping Cache Save for Node 4 as its not past QueryStage_CacheLoad
,2020-03-03 13:19:52.407 Info, Node005, Skipping Cache Save for Node 5 as its not past QueryStage_CacheLoad
,2020-03-03 13:19:52.407 Info, Node006, Skipping Cache Save for Node 6 as its not past QueryStage_CacheLoad
,2020-03-03 13:19:52.408 Detail, Node005, Notification: Notification - NoOperation
,2020-03-03 13:19:52.409 Detail, Node005, Notification: Notification - Node Asleep
,2020-03-03 13:19:52.409 Detail, 
,2020-03-03 13:19:52.409 Info, Node006, Sending (Query) message (Callback ID=0x00, Expected Reply=0x41) - Get Node Protocol Info (Node=6): 0x01, 0x04, 0x00, 0x41, 0x06, 0xbc
,2020-03-03 13:19:52.409 Info, Node006, Encrypted Flag is 0
,  z2m:Zwave Notification from node 5: Notification - NoOperation (2) +4s
,  z2m:Zwave Notification from node 5: Notification - Node Asleep (4) +1ms
,2020-03-03 13:19:52.411 Detail, Node006,   Received: 0x01, 0x09, 0x01, 0x41, 0x53, 0x9c, 0x01, 0x04, 0x07, 0x01, 0x7a
,2020-03-03 13:19:52.411 Detail, 
,2020-03-03 13:19:52.411 Info, Node006, Received reply to FUNC_ID_ZW_GET_NODE_PROTOCOL_INFO
,2020-03-03 13:19:52.411 Info, Node006,   Protocol Info for Node 6:
,2020-03-03 13:19:52.411 Info, Node006,     Listening     = false
,2020-03-03 13:19:52.411 Info, Node006,     Frequent      = false
,2020-03-03 13:19:52.411 Info, Node006,     Beaming       = true
,2020-03-03 13:19:52.411 Info, Node006,     Routing       = true
,2020-03-03 13:19:52.411 Info, Node006,     Max Baud Rate = 100000
,2020-03-03 13:19:52.411 Info, Node006,     Version       = 4
,2020-03-03 13:19:52.411 Info, Node006,     Security      = false
,2020-03-03 13:19:52.411 Info, Node006,   Basic device class    (0x04) - Routing Slave
,2020-03-03 13:19:52.411 Info, Node006,   Generic device Class  (0x07) - Notification Sensor
,2020-03-03 13:19:52.411 Info, Node006,   Specific device class (0x01) - Notification Sensor
,2020-03-03 13:19:52.412 Info, Node006,   Mandatory Command Classes for Node 6:
,2020-03-03 13:19:52.412 Info, Node006,     COMMAND_CLASS_BASIC
,2020-03-03 13:19:52.412 Info, Node006,     COMMAND_CLASS_MANUFACTURER_SPECIFIC
,2020-03-03 13:19:52.412 Info, Node006,     COMMAND_CLASS_WAKE_UP
,2020-03-03 13:19:52.412 Info, Node006,   Mandatory Command Classes controlled by Node 6:
,2020-03-03 13:19:52.412 Info, Node006,     None
,2020-03-03 13:19:52.412 Detail, Node006,   Expected reply was received
,2020-03-03 13:19:52.412 Detail, Node006,   Message transaction complete
,2020-03-03 13:19:52.412 Detail, 
,2020-03-03 13:19:52.412 Detail, Node006, Removing current message
,2020-03-03 13:19:52.412 Detail, Node006, Notification: NodeProtocolInfo
,2020-03-03 13:19:52.412 Detail, Node006, Query Stage Complete (ProtocolInfo)
,2020-03-03 13:19:52.412 Detail, Node006, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Probe live=1
,2020-03-03 13:19:52.412 Detail, Node006, QueryStage_Probe
,2020-03-03 13:19:52.412 Info, Node006, NoOperation::Set - Routing=true
,2020-03-03 13:19:52.412 Detail, Node006, Queuing (NoOp) NoOperation_Set (Node=6): 0x01, 0x09, 0x00, 0x13, 0x06, 0x02, 0x00, 0x00, 0x25, 0x0f, 0xcb
,2020-03-03 13:19:52.412 Detail, Node006, Queuing (Query) Query Stage Complete (Probe)
,2020-03-03 13:19:52.412 Detail, 
,2020-03-03 13:19:52.412 Info, Node006, Sending (NoOp) message (Callback ID=0x0f, Expected Reply=0x13) - NoOperation_Set (Node=6): 0x01, 0x09, 0x00, 0x13, 0x06, 0x02, 0x00, 0x00, 0x25, 0x0f, 0xcb
,2020-03-03 13:19:52.412 Info, Node006, Encrypted Flag is 0
,2020-03-03 13:19:52.420 Detail, Node006,   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
,2020-03-03 13:19:52.420 Detail, Node006,   ZW_SEND_DATA delivered to Z-Wave stack
,2020-03-03 13:19:56.820 Detail, Node006,   Received: 0x01, 0x18, 0x00, 0x13, 0x0f, 0x01, 0x01, 0xb8, 0x00, 0x7f, 0x7f, 0x7f, 0x7f, 0x7f, 0x00, 0x01, 0x07, 0x00, 0x00, 0x00, 0x00, 0x02, 0x0a, 0x00, 0x00, 0x32
,2020-03-03 13:19:56.820 Detail, Node006,   ZW_SEND_DATA Request with callback ID 0x0f received (expected 0x0f)
,2020-03-03 13:19:56.820 Detail, Node006, Extended TxStatus: Time: 4400, Hops: 0, Rssi: --- --- --- --- ---, AckChannel: 0, TxChannel: 1, RouteScheme: Explorer Route, Route: 0 0 0 0, RouteSpeed: 40K, RouteTries: 10, FailedLinkFrom: 0, FailedLinkTo: 0
,2020-03-03 13:19:56.820 Info, Node006, WARNING: ZW_SEND_DATA failed. No ACK received - device may be asleep.
,2020-03-03 13:19:56.820 Info, Node006,   Node 6 has been marked as asleep
,2020-03-03 13:19:56.820 Info, Node006, Node not responding - moving QueryStageComplete command to Wake-Up queue
,2020-03-03 13:19:56.820 Warning, CheckCompletedNodeQueries m_allNodesQueried=0 m_awakeNodesQueried=1
,2020-03-03 13:19:56.820 Warning, CheckCompletedNodeQueries all=0, deadFound=0 sleepingOnly=0
,2020-03-03 13:19:56.820 Info, Saving Cache
,2020-03-03 13:19:56.820 Info, Node001, Cache Save for Node 1 as its QueryStage_CacheLoad
,2020-03-03 13:19:56.820 Info, Node004, Skipping Cache Save for Node 4 as its not past QueryStage_CacheLoad
,2020-03-03 13:19:56.820 Info, Node005, Skipping Cache Save for Node 5 as its not past QueryStage_CacheLoad
,2020-03-03 13:19:56.820 Info, Node006, Skipping Cache Save for Node 6 as its not past QueryStage_CacheLoad
,2020-03-03 13:19:56.820 Detail, Node006, Notification: Notification - NoOperation
,2020-03-03 13:19:56.820 Detail, Node006, Notification: Notification - Node Asleep
,2020-03-03 13:19:56.820 Detail, Node001, Query Stage Complete (Neighbors)
,2020-03-03 13:19:56.820 Detail, Node001, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Session live=1
,2020-03-03 13:19:56.820 Detail, Node001, QueryStage_Session
,2020-03-03 13:19:56.820 Detail, Node001, QueryStage_Dynamic
,2020-03-03 13:19:56.820 Detail, Node001, QueryStage_Configuration
,2020-03-03 13:19:56.820 Detail, Node001, QueryStage_Complete
,2020-03-03 13:19:56.820 Warning, CheckCompletedNodeQueries m_allNodesQueried=0 m_awakeNodesQueried=1
,2020-03-03 13:19:56.820 Warning, CheckCompletedNodeQueries all=0, deadFound=0 sleepingOnly=1
,2020-03-03 13:19:56.821 Info, Saving Cache
,2020-03-03 13:19:56.821 Info, Node001, Cache Save for Node 1 as its QueryStage_CacheLoad
,2020-03-03 13:19:56.821 Info, Node004, Skipping Cache Save for Node 4 as its not past QueryStage_CacheLoad
,2020-03-03 13:19:56.821 Info, Node005, Skipping Cache Save for Node 5 as its not past QueryStage_CacheLoad
,2020-03-03 13:19:56.821 Info, Node006, Skipping Cache Save for Node 6 as its not past QueryStage_CacheLoad
,  z2m:Zwave Notification from node 6: Notification - NoOperation (2) +4s
,2020-03-03 13:19:56.821 Detail, Node001, Notification: NodeQueriesComplete
,  z2m:Zwave Notification from node 6: Notification - Node Asleep (4) +0ms
,  z2m:Zwave node 1 ready: Z-Wave.Me - ZME_UZB1 USB Stick (Static PC Controller) +1ms
,  z2m:Mqtt Message received on hass/status +28s
,  z2m:Gateway Home Assistant is ONLINE +28s
,GET / 304 10.880 ms - -
,  z2m:App User disconnected 50JzpvIIXaPvpNoVAAAA +29s
,GET /static/css/app.6071a1385bbbf2e6bba673b992155bbf.css 304 2.685 ms - -
,GET /static/js/manifest.2ae2e69a05c33dfc65f8.js 304 4.896 ms - -
,GET /static/js/vendor.232393204655456e084d.js 304 4.800 ms - -
,GET /static/js/app.e8d7c6e9965f090643b4.js 304 3.357 ms - -
,  z2m:App New connection auUg6-MiAafcqAT3AAAB +207ms
,GET /static/logo.png 304 1.058 ms - -
,GET /static/favicons/favicon-32x32.png 200 2.394 ms - 1831
,GET /api/settings 200 86.053 ms - 2550
,  z2m:App Zwave api call: refreshNeighborns [] +15s
,  z2m:Zwave Success zwave api call refreshNeighborns [ undefined, [ 4, 5, 6 ], undefined, undefined, [], [], [] ] +18s
,GET /api/settings 304 61.884 ms - -
,2020-03-03 13:21:05.988 Detail, Node006,   Received: 0x01, 0x0c, 0x00, 0x04, 0x00, 0x06, 0x04, 0x30, 0x03, 0xff, 0x0a, 0xc7, 0x00, 0xf4
,2020-03-03 13:21:05.988 Detail, 
,2020-03-03 13:21:05.988 Info, Node006, ApplicationCommandHandler - Unhandled Command Class 0x30
,2020-03-03 13:21:06.007 Detail, Node006,   Received: 0x01, 0x11, 0x00, 0x04, 0x00, 0x06, 0x09, 0x71, 0x05, 0x00, 0x00, 0x00, 0xff, 0x06, 0x16, 0x00, 0xc7, 0x00, 0xb9
,2020-03-03 13:21:06.007 Detail, 
,2020-03-03 13:21:06.007 Info, Node006, ApplicationCommandHandler - Unhandled Command Class 0x71
,2020-03-03 13:21:31.837 Detail, Node006,   Received: 0x01, 0x0c, 0x00, 0x04, 0x00, 0x06, 0x04, 0x30, 0x03, 0x00, 0x0a, 0xc9, 0x00, 0x05
,2020-03-03 13:21:31.837 Detail, 
,2020-03-03 13:21:31.837 Info, Node006, ApplicationCommandHandler - Unhandled Command Class 0x30
,2020-03-03 13:21:31.856 Detail, Node006,   Received: 0x01, 0x11, 0x00, 0x04, 0x00, 0x06, 0x09, 0x71, 0x05, 0x00, 0x00, 0x00, 0xff, 0x06, 0x17, 0x00, 0xc9, 0x00, 0xb6
,2020-03-03 13:21:31.856 Detail, 
,2020-03-03 13:21:31.856 Info, Node006, ApplicationCommandHandler - Unhandled Command Class 0x71
,2020-03-03 13:21:41.918 Detail, Node004,   Received: 0x01, 0x0c, 0x00, 0x04, 0x00, 0x04, 0x04, 0x30, 0x03, 0xff, 0x0a, 0xc1, 0x00, 0xf0
,2020-03-03 13:21:41.918 Detail, 
,2020-03-03 13:21:41.918 Info, Node004, ApplicationCommandHandler - Unhandled Command Class 0x30
,2020-03-03 13:21:41.937 Detail, Node004,   Received: 0x01, 0x11, 0x00, 0x04, 0x00, 0x04, 0x09, 0x71, 0x05, 0x00, 0x00, 0x00, 0xff, 0x06, 0x16, 0x00, 0xc1, 0x00, 0xbd
,2020-03-03 13:21:41.937 Detail, 
,2020-03-03 13:21:41.937 Info, Node004, ApplicationCommandHandler - Unhandled Command Class 0x71
,2020-03-03 13:21:41.954 Detail, Node004,   Received: 0x01, 0x0c, 0x00, 0x04, 0x00, 0x04, 0x04, 0x30, 0x03, 0xff, 0x08, 0xc1, 0x00, 0xf2
,2020-03-03 13:21:41.954 Detail, 
,2020-03-03 13:21:41.955 Info, Node004, ApplicationCommandHandler - Unhandled Command Class 0x30
,2020-03-03 13:21:41.973 Detail, Node004,   Received: 0x01, 0x11, 0x00, 0x04, 0x00, 0x04, 0x09, 0x71, 0x05, 0x00, 0x00, 0x00, 0xff, 0x07, 0x03, 0x00, 0xbf, 0x00, 0xd7
,2020-03-03 13:21:41.973 Detail, 
,2020-03-03 13:21:41.973 Info, Node004, ApplicationCommandHandler - Unhandled Command Class 0x71
,2020-03-03 13:21:41.990 Detail, Node004,   Received: 0x01, 0x0b, 0x00, 0x04, 0x00, 0x04, 0x03, 0x80, 0x03, 0x58, 0xc1, 0x00, 0xed
,2020-03-03 13:21:41.991 Detail, 
,2020-03-03 13:21:41.991 Info, Node004, ApplicationCommandHandler - Unhandled Command Class 0x80
,  z2m:App Zwave api call: healNetwork [] +2m
,2020-03-03 13:22:03.164 Detail, Node001, Queuing (Controller) Request Node Neighbor Update
,2020-03-03 13:22:03.164 Detail, Node004, Queuing (Controller) Request Node Neighbor Update
,2020-03-03 13:22:03.164 Detail, Node005, Queuing (Controller) Request Node Neighbor Update
,2020-03-03 13:22:03.164 Detail, Node006, Queuing (Controller) Request Node Neighbor Update
,2020-03-03 13:22:03.165 Info, Requesting Neighbor Update for node 1
,2020-03-03 13:22:03.165 Detail, Node001, Queuing (Command) ControllerCommand_RequestNodeNeighborUpdate (Node=1): 0x01, 0x05, 0x00, 0x48, 0x01, 0x10, 0xa3
,  z2m:Zwave Success zwave api call healNetwork  +2m
,2020-03-03 13:22:03.165 Detail, Node001, Notification: RequestNodeNeighborUpdate ControllerCommand - Starting
,2020-03-03 13:22:03.165 Detail, 
,2020-03-03 13:22:03.165 Info, Node001, Sending (Command) message (Callback ID=0x10, Expected Reply=0x48) - ControllerCommand_RequestNodeNeighborUpdate (Node=1): 0x01, 0x05, 0x00, 0x48, 0x01, 0x10, 0xa3
,2020-03-03 13:22:03.165 Info, Node001, Encrypted Flag is 0
,  z2m:Zwave controller command {
,  nodeid: 1,
,  state: 1,
,  errcode: 0,
,  help: 'RequestNodeNeighborUpdate Starting'
,} +1ms
,2020-03-03 13:22:03.194 Detail, Node001,   Received: 0x01, 0x05, 0x00, 0x48, 0x10, 0x23, 0x81
,2020-03-03 13:22:03.194 Detail, 
,2020-03-03 13:22:03.195 Warning, Node001, WARNING: REQUEST_NEIGHBOR_UPDATE_FAILED
,2020-03-03 13:22:03.195 Detail, Node001,   Expected callbackId was received
,2020-03-03 13:22:03.195 Detail, Node001,   Expected reply was received
,2020-03-03 13:22:03.195 Detail, Node001,   Message transaction complete
,2020-03-03 13:22:03.195 Detail, 
,2020-03-03 13:22:03.195 Detail, Node001, Removing current message
,2020-03-03 13:22:03.195 Detail, Node001, Notification: RequestNodeNeighborUpdate ControllerCommand - Failed
,2020-03-03 13:22:03.195 Info, Requesting Neighbor Update for node 4
,2020-03-03 13:22:03.195 Detail, 
,2020-03-03 13:22:03.196 Detail, Node004, Queuing (Controller) Request Node Neighbor Update
,2020-03-03 13:22:03.196 Detail, Node004, Notification: RequestNodeNeighborUpdate ControllerCommand - Starting
,2020-03-03 13:22:03.196 Detail, Node004, Notification: RequestNodeNeighborUpdate ControllerCommand - Sleeping
,2020-03-03 13:22:03.196 Info, Requesting Neighbor Update for node 5
,2020-03-03 13:22:03.196 Detail, 
,2020-03-03 13:22:03.196 Detail, Node005, Queuing (Controller) Request Node Neighbor Update
,2020-03-03 13:22:03.196 Detail, Node005, Notification: RequestNodeNeighborUpdate ControllerCommand - Starting
,2020-03-03 13:22:03.196 Detail, Node005, Notification: RequestNodeNeighborUpdate ControllerCommand - Sleeping
,2020-03-03 13:22:03.196 Info, Requesting Neighbor Update for node 6
,2020-03-03 13:22:03.197 Detail, 
,2020-03-03 13:22:03.197 Detail, Node006, Queuing (Controller) Request Node Neighbor Update
,2020-03-03 13:22:03.197 Detail, Node006, Notification: RequestNodeNeighborUpdate ControllerCommand - Starting
,2020-03-03 13:22:03.197 Detail, Node006, Notification: RequestNodeNeighborUpdate ControllerCommand - Sleeping
,  z2m:Zwave controller command {
,  nodeid: 1,
,  state: 8,
,  errcode: 0,
,  help: 'RequestNodeNeighborUpdate Failed'
,} +30ms
,  z2m:Zwave controller command {
,  nodeid: 4,
,  state: 1,
,  errcode: 0,
,  help: 'RequestNodeNeighborUpdate Starting'
,} +2ms
,  z2m:Zwave controller command {
,  nodeid: 4,
,  state: 5,
,  errcode: 0,
,  help: 'RequestNodeNeighborUpdate Sleeping'
,} +1ms
,  z2m:Zwave controller command {
,  nodeid: 5,
,  state: 1,
,  errcode: 0,
,  help: 'RequestNodeNeighborUpdate Starting'
,} +2ms
,  z2m:Zwave controller command {
,  nodeid: 5,
,  state: 5,
,  errcode: 0,
,  help: 'RequestNodeNeighborUpdate Sleeping'
,} +1ms
,  z2m:Zwave controller command {
,  nodeid: 6,
,  state: 1,
,  errcode: 0,
,  help: 'RequestNodeNeighborUpdate Starting'
,} +2ms
,  z2m:Zwave controller command {
,  nodeid: 6,
,  state: 5,
,  errcode: 0,
,  help: 'RequestNodeNeighborUpdate Sleeping'
,} +1ms
,  z2m:App Zwave api call: removeNode [] +3s
,2020-03-03 13:22:06.401 Detail, Queuing (Controller) Remove Device
,2020-03-03 13:22:06.401 Info, Remove Device
,  z2m:Zwave Success zwave api call removeNode true +3s
,2020-03-03 13:22:06.402 Detail, contrlr, Queuing (Command) ControllerCommand_RemoveDevice: 0x01, 0x05, 0x00, 0x4b, 0x81, 0x14, 0x24
,2020-03-03 13:22:06.402 Detail, Notification: RemoveDevice ControllerCommand - Starting
,2020-03-03 13:22:06.402 Detail, 
,2020-03-03 13:22:06.402 Info, contrlr, Sending (Command) message (Callback ID=0x14, Expected Reply=0x4b) - ControllerCommand_RemoveDevice: 0x01, 0x05, 0x00, 0x4b, 0x81, 0x14, 0x24
,2020-03-03 13:22:06.402 Info, contrlr, Encrypted Flag is 0
,  z2m:Zwave controller command { nodeid: 0, state: 1, errcode: 0, help: 'RemoveDevice Starting' } +2ms
,2020-03-03 13:22:06.406 Detail, contrlr,   Received: 0x01, 0x07, 0x00, 0x4b, 0x14, 0x01, 0x00, 0x00, 0xa6
,2020-03-03 13:22:06.406 Detail, 
,2020-03-03 13:22:06.406 Info, FUNC_ID_ZW_REMOVE_NODE_FROM_NETWORK:
,2020-03-03 13:22:06.406 Info, REMOVE_NODE_STATUS_LEARN_READY
,2020-03-03 13:22:06.406 Detail, contrlr,   Expected callbackId was received
,2020-03-03 13:22:06.406 Detail, contrlr,   Expected reply was received
,2020-03-03 13:22:06.406 Detail, contrlr,   Message transaction complete
,2020-03-03 13:22:06.406 Detail, 
,2020-03-03 13:22:06.406 Detail, contrlr, Removing current message
,2020-03-03 13:22:06.406 Detail, Notification: RemoveDevice ControllerCommand - Waiting
,2020-03-03 13:22:06.406 Info, WriteNextMsg Controller nothing to do
,  z2m:Zwave controller command { nodeid: 0, state: 4, errcode: 0, help: 'RemoveDevice Waiting' } +3ms
,2020-03-03 13:22:09.798 Detail,   Received: 0x01, 0x07, 0x00, 0x4b, 0x14, 0x02, 0x00, 0x00, 0xa5
,2020-03-03 13:22:09.798 Detail, 
,2020-03-03 13:22:09.798 Info, FUNC_ID_ZW_REMOVE_NODE_FROM_NETWORK:
,2020-03-03 13:22:09.798 Info, REMOVE_NODE_STATUS_NODE_FOUND
,2020-03-03 13:22:09.798 Detail, Notification: RemoveDevice ControllerCommand - InProgress
,  z2m:Zwave controller command { nodeid: 0, state: 6, errcode: 0, help: 'RemoveDevice InProgress' } +3s
,2020-03-03 13:22:10.000 Detail,   Received: 0x01, 0x16, 0x00, 0x4b, 0x14, 0x03, 0x04, 0x0f, 0x04, 0x07, 0x01, 0x5e, 0x30, 0x84, 0x80, 0x86, 0x72, 0x71, 0x70, 0x85, 0x59, 0x73, 0x5a, 0xd6
,2020-03-03 13:22:10.000 Detail, 
,2020-03-03 13:22:10.000 Info, FUNC_ID_ZW_REMOVE_NODE_FROM_NETWORK:
,2020-03-03 13:22:10.001 Info, REMOVE_NODE_STATUS_REMOVING_SLAVE
,2020-03-03 13:22:10.001 Info, Removing node ID 4
,2020-03-03 13:22:10.001 Detail, Node004, Notification: RemoveDevice ControllerCommand - InProgress
,2020-03-03 13:22:10.004 Detail,   Received: 0x01, 0x16, 0x00, 0x4b, 0x14, 0x06, 0x04, 0x0f, 0x04, 0x07, 0x01, 0x5e, 0x30, 0x84, 0x80, 0x86, 0x72, 0x71, 0x70, 0x85, 0x59, 0x73, 0x5a, 0xd3
,2020-03-03 13:22:10.004 Detail, 
,2020-03-03 13:22:10.004 Info, FUNC_ID_ZW_REMOVE_NODE_FROM_NETWORK:
,2020-03-03 13:22:10.004 Info, REMOVE_NODE_STATUS_DONE
,2020-03-03 13:22:10.004 Info, Saving Cache
,2020-03-03 13:22:10.004 Info, Node001, Cache Save for Node 1 as its QueryStage_CacheLoad
,2020-03-03 13:22:10.004 Info, Node005, Skipping Cache Save for Node 5 as its not past QueryStage_CacheLoad
,2020-03-03 13:22:10.005 Info, Node006, Skipping Cache Save for Node 6 as its not past QueryStage_CacheLoad
,  z2m:Zwave controller command { nodeid: 4, state: 6, errcode: 0, help: 'RemoveDevice InProgress' } +206ms
,2020-03-03 13:22:10.006 Detail, Node004, Notification: RemoveDevice ControllerCommand - Completed
,2020-03-03 13:22:10.006 Detail, Node004, Notification: NodeRemoved
,  z2m:Zwave controller command { nodeid: 4, state: 7, errcode: 0, help: 'RemoveDevice Completed' } +4ms
,  z2m:Zwave Node removed 4 +1ms
,  z2m:App Zwave api call: refreshNeighborns [] +4s
,  z2m:Zwave Success zwave api call refreshNeighborns [ undefined, [ 4, 5, 6 ], undefined, undefined, undefined, [], [] ] +28ms
,  z2m:App Zwave api call: addNode [ false ] +13s
,2020-03-03 13:22:22.824 Detail, Queuing (Controller) Add Device
,2020-03-03 13:22:22.824 Info, Add Device
,2020-03-03 13:22:22.824 Detail, contrlr, Queuing (Command) ControllerCommand_AddDevice: 0x01, 0x05, 0x00, 0x4a, 0xc1, 0x15, 0x64
,  z2m:Zwave Success zwave api call addNode true +13s
,2020-03-03 13:22:22.824 Detail, Notification: AddDevice ControllerCommand - Starting
,2020-03-03 13:22:22.825 Detail, 
,2020-03-03 13:22:22.825 Info, contrlr, Sending (Command) message (Callback ID=0x15, Expected Reply=0x4a) - ControllerCommand_AddDevice: 0x01, 0x05, 0x00, 0x4a, 0xc1, 0x15, 0x64
,2020-03-03 13:22:22.825 Info, contrlr, Encrypted Flag is 0
,  z2m:Zwave controller command { nodeid: 0, state: 1, errcode: 0, help: 'AddDevice Starting' } +1ms
,2020-03-03 13:22:22.828 Detail, contrlr,   Received: 0x01, 0x07, 0x00, 0x4a, 0x15, 0x01, 0x00, 0x00, 0xa6
,2020-03-03 13:22:22.828 Detail, 
,2020-03-03 13:22:22.828 Info, contrlr, FUNC_ID_ZW_ADD_NODE_TO_NETWORK:
,2020-03-03 13:22:22.828 Info, contrlr, ADD_NODE_STATUS_LEARN_READY
,2020-03-03 13:22:22.828 Detail, contrlr,   Expected callbackId was received
,2020-03-03 13:22:22.828 Detail, contrlr,   Expected reply was received
,2020-03-03 13:22:22.828 Detail, contrlr,   Message transaction complete
,2020-03-03 13:22:22.828 Detail, 
,2020-03-03 13:22:22.828 Detail, contrlr, Removing current message
,2020-03-03 13:22:22.828 Detail, Notification: AddDevice ControllerCommand - Waiting
,2020-03-03 13:22:22.828 Info, WriteNextMsg Controller nothing to do
,  z2m:Zwave controller command { nodeid: 0, state: 4, errcode: 0, help: 'AddDevice Waiting' } +4ms
,2020-03-03 13:22:25.471 Detail,   Received: 0x01, 0x07, 0x00, 0x4a, 0x15, 0x02, 0x00, 0x00, 0xa5
,2020-03-03 13:22:25.472 Detail, 
,2020-03-03 13:22:25.472 Info, FUNC_ID_ZW_ADD_NODE_TO_NETWORK:
,2020-03-03 13:22:25.472 Info, ADD_NODE_STATUS_NODE_FOUND
,2020-03-03 13:22:25.472 Detail, Notification: AddDevice ControllerCommand - InProgress
,  z2m:Zwave controller command { nodeid: 0, state: 6, errcode: 0, help: 'AddDevice InProgress' } +3s
,2020-03-03 13:22:25.647 Detail,   Received: 0x01, 0x16, 0x00, 0x4a, 0x15, 0x03, 0x07, 0x0f, 0x04, 0x07, 0x01, 0x5e, 0x30, 0x84, 0x80, 0x86, 0x72, 0x71, 0x70, 0x85, 0x59, 0x73, 0x5a, 0xd5
,2020-03-03 13:22:25.647 Detail, 
,2020-03-03 13:22:25.647 Info, FUNC_ID_ZW_ADD_NODE_TO_NETWORK:
,2020-03-03 13:22:25.647 Info, ADD_NODE_STATUS_ADDING_SLAVE
,2020-03-03 13:22:25.647 Info, Adding node ID 7 - Non-Secure
,2020-03-03 13:22:25.648 Detail, Node007, Notification: AddDevice ControllerCommand - InProgress
,  z2m:Zwave controller command { nodeid: 7, state: 6, errcode: 0, help: 'AddDevice InProgress' } +176ms
,2020-03-03 13:22:25.926 Detail,   Received: 0x01, 0x07, 0x00, 0x4a, 0x15, 0x05, 0x07, 0x00, 0xa5
,2020-03-03 13:22:25.926 Detail, 
,2020-03-03 13:22:25.926 Info, FUNC_ID_ZW_ADD_NODE_TO_NETWORK:
,2020-03-03 13:22:25.926 Info, ADD_NODE_STATUS_PROTOCOL_DONE
,2020-03-03 13:22:25.926 Detail, contrlr, Queuing (Command) Add Node Stop: 0x01, 0x04, 0x00, 0x4a, 0x05, 0xb4
,2020-03-03 13:22:25.926 Detail, Node007, Notification: AddDevice ControllerCommand - InProgress
,2020-03-03 13:22:25.926 Detail, 
,2020-03-03 13:22:25.926 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x4a) - Add Node Stop: 0x01, 0x04, 0x00, 0x4a, 0x05, 0xb4
,2020-03-03 13:22:25.926 Info, contrlr, Encrypted Flag is 0
,  z2m:Zwave controller command { nodeid: 7, state: 6, errcode: 0, help: 'AddDevice InProgress' } +279ms
,2020-03-03 13:22:25.978 Detail, contrlr,   Received: 0x01, 0x07, 0x00, 0x4a, 0x15, 0x06, 0x07, 0x00, 0xa6
,2020-03-03 13:22:25.978 Detail, 
,2020-03-03 13:22:25.978 Info, contrlr, FUNC_ID_ZW_ADD_NODE_TO_NETWORK:
,2020-03-03 13:22:25.978 Info, contrlr, ADD_NODE_STATUS_DONE
,2020-03-03 13:22:25.978 Info, Node007, Network Key Not Set - Secure Option is not required
,2020-03-03 13:22:25.978 Info, Node007,   Basic device class    (0x04) - Routing Slave
,2020-03-03 13:22:25.978 Info, Node007,   Generic device Class  (0x07) - Notification Sensor
,2020-03-03 13:22:25.979 Info, Node007,   Specific device class (0x01) - Notification Sensor
,2020-03-03 13:22:25.979 Info, Node007,   Mandatory Command Classes for Node 7:
,2020-03-03 13:22:25.979 Info, Node007,     COMMAND_CLASS_BASIC
,2020-03-03 13:22:25.979 Info, Node007,     COMMAND_CLASS_MANUFACTURER_SPECIFIC
,2020-03-03 13:22:25.979 Info, Node007,   Mandatory Command Classes controlled by Node 7:
,2020-03-03 13:22:25.979 Info, Node007,     None
,2020-03-03 13:22:25.979 Info, Node007,   Optional CommandClasses for node 7:
,2020-03-03 13:22:25.979 Info, Node007,     COMMAND_CLASS_ZWAVEPLUS_INFO
,2020-03-03 13:22:25.979 Info, Node007,     COMMAND_CLASS_SENSOR_BINARY
,2020-03-03 13:22:25.979 Info, Node007,     COMMAND_CLASS_WAKE_UP
,2020-03-03 13:22:25.979 Info, Node007,     COMMAND_CLASS_BATTERY
,2020-03-03 13:22:25.979 Info, Node007,     COMMAND_CLASS_VERSION
,2020-03-03 13:22:25.979 Info, Node007,     COMMAND_CLASS_MANUFACTURER_SPECIFIC (Existing)
,2020-03-03 13:22:25.979 Info, Node007,     COMMAND_CLASS_NOTIFICATION
,2020-03-03 13:22:25.980 Info, Node007,     COMMAND_CLASS_CONFIGURATION
,2020-03-03 13:22:25.980 Info, Node007,     COMMAND_CLASS_ASSOCIATION
,2020-03-03 13:22:25.980 Info, Node007,   CommandClass 0x59 - NOT REQUIRED
,2020-03-03 13:22:25.980 Info, Node007,     COMMAND_CLASS_POWERLEVEL
,2020-03-03 13:22:25.980 Info, Node007,     COMMAND_CLASS_DEVICE_RESET_LOCALLY
,2020-03-03 13:22:25.980 Detail, Node007, AdvanceQueries queryPending=0 queryRetries=0 queryStage=None live=1
,2020-03-03 13:22:25.980 Detail, Node007, QueryStage_ProtocolInfo
,2020-03-03 13:22:25.980 Detail, Node007, Queuing (Query) Get Node Protocol Info (Node=7): 0x01, 0x04, 0x00, 0x41, 0x07, 0xbd
,2020-03-03 13:22:25.980 Detail, Node007, Queuing (Query) Query Stage Complete (ProtocolInfo)
,2020-03-03 13:22:25.980 Info, Node007, Initializing Node. New Node: true (true)
,2020-03-03 13:22:25.980 Detail, contrlr,   Expected reply was received
,2020-03-03 13:22:25.980 Detail, contrlr,   Message transaction complete
,2020-03-03 13:22:25.980 Detail, 
,2020-03-03 13:22:25.980 Detail, contrlr, Removing current message
,2020-03-03 13:22:25.980 Detail, Node007, Notification: NodeAdded
,2020-03-03 13:22:25.981 Detail, Node007, Notification: NodeProtocolInfo
,2020-03-03 13:22:25.981 Detail, Node007, Notification: AddDevice ControllerCommand - Completed
,2020-03-03 13:22:25.981 Detail, 
,2020-03-03 13:22:25.981 Info, Node007, Sending (Query) message (Callback ID=0x00, Expected Reply=0x41) - Get Node Protocol Info (Node=7): 0x01, 0x04, 0x00, 0x41, 0x07, 0xbd
,2020-03-03 13:22:25.981 Info, Node007, Encrypted Flag is 0
,  z2m:Zwave Node added 7 +54ms
,  z2m:Zwave controller command { nodeid: 7, state: 7, errcode: 0, help: 'AddDevice Completed' } +1ms
,2020-03-03 13:22:25.983 Detail, Node007,   Received: 0x01, 0x09, 0x01, 0x41, 0x53, 0x9c, 0x01, 0x04, 0x07, 0x01, 0x7a
,2020-03-03 13:22:25.983 Detail, 
,2020-03-03 13:22:25.983 Info, Node007, Received reply to FUNC_ID_ZW_GET_NODE_PROTOCOL_INFO
,2020-03-03 13:22:25.983 Info, Node007,   Protocol Info for Node 7:
,2020-03-03 13:22:25.983 Info, Node007,     Listening     = false
,2020-03-03 13:22:25.983 Info, Node007,     Frequent      = false
,2020-03-03 13:22:25.983 Info, Node007,     Beaming       = true
,2020-03-03 13:22:25.983 Info, Node007,     Routing       = true
,2020-03-03 13:22:25.983 Info, Node007,     Max Baud Rate = 100000
,2020-03-03 13:22:25.983 Info, Node007,     Version       = 4
,2020-03-03 13:22:25.983 Info, Node007,     Security      = false
,2020-03-03 13:22:25.983 Detail, Node007,   Expected reply was received
,2020-03-03 13:22:25.983 Detail, Node007,   Message transaction complete
,2020-03-03 13:22:25.983 Detail, 
,2020-03-03 13:22:25.983 Detail, Node007, Removing current message
,2020-03-03 13:22:25.983 Detail, Node007, Query Stage Complete (ProtocolInfo)
,2020-03-03 13:22:25.983 Detail, Node007, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Probe live=1
,2020-03-03 13:22:25.983 Detail, Node007, QueryStage_Probe
,2020-03-03 13:22:25.983 Info, Node007, NoOperation::Set - Routing=true
,2020-03-03 13:22:25.984 Detail, Node007, Queuing (NoOp) NoOperation_Set (Node=7): 0x01, 0x09, 0x00, 0x13, 0x07, 0x02, 0x00, 0x00, 0x25, 0x16, 0xd3
,2020-03-03 13:22:25.984 Detail, Node007, Queuing (Query) Query Stage Complete (Probe)
,2020-03-03 13:22:25.984 Detail, 
,2020-03-03 13:22:25.984 Info, Node007, Sending (NoOp) message (Callback ID=0x16, Expected Reply=0x13) - NoOperation_Set (Node=7): 0x01, 0x09, 0x00, 0x13, 0x07, 0x02, 0x00, 0x00, 0x25, 0x16, 0xd3
,2020-03-03 13:22:25.984 Info, Node007, Encrypted Flag is 0
,2020-03-03 13:22:25.991 Detail, Node007,   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
,2020-03-03 13:22:25.992 Detail, Node007,   ZW_SEND_DATA delivered to Z-Wave stack
,2020-03-03 13:22:26.012 Detail, Node007,   Received: 0x01, 0x18, 0x00, 0x13, 0x16, 0x00, 0x00, 0x02, 0x00, 0xcf, 0x7f, 0x7f, 0x7f, 0x7f, 0x00, 0x00, 0x04, 0x00, 0x00, 0x00, 0x00, 0x03, 0x01, 0x00, 0x00, 0x29
,2020-03-03 13:22:26.012 Detail, Node007,   ZW_SEND_DATA Request with callback ID 0x16 received (expected 0x16)
,2020-03-03 13:22:26.012 Info, Node007, Request RTT 29 Average Request RTT 29
,2020-03-03 13:22:26.012 Detail, Node007, Extended TxStatus: Time: 20, Hops: 0, Rssi:  -49 --- --- --- ---, AckChannel: 0, TxChannel: 0, RouteScheme: Next to Last Working Route, Route: 0 0 0 0, RouteSpeed: 100K, RouteTries: 1, FailedLinkFrom: 0, FailedLinkTo: 0
,2020-03-03 13:22:26.012 Detail, Node007,   Expected callbackId was received
,2020-03-03 13:22:26.012 Detail, Node007,   Expected reply was received
,2020-03-03 13:22:26.012 Detail, Node007,   Message transaction complete
,2020-03-03 13:22:26.013 Detail, 
,2020-03-03 13:22:26.013 Detail, Node007, Removing current message
,2020-03-03 13:22:26.013 Detail, Node007, Notification: Notification - NoOperation
,2020-03-03 13:22:26.013 Detail, Node007, Query Stage Complete (Probe)
,2020-03-03 13:22:26.013 Detail, Node007, AdvanceQueries queryPending=0 queryRetries=0 queryStage=WakeUp live=1
,2020-03-03 13:22:26.013 Detail, Node007, QueryStage_WakeUp
,2020-03-03 13:22:26.013 Detail, Node007, Queuing (WakeUp) WakeUpCmd_IntervalGet (Node=7): 0x01, 0x09, 0x00, 0x13, 0x07, 0x02, 0x84, 0x05, 0x25, 0x17, 0x53
,2020-03-03 13:22:26.013 Detail, Node007, Queuing (Query) Query Stage Complete (WakeUp)
,2020-03-03 13:22:26.013 Detail, 
,2020-03-03 13:22:26.013 Info, Node007, Sending (WakeUp) message (Callback ID=0x17, Expected Reply=0x04) - WakeUpCmd_IntervalGet (Node=7): 0x01, 0x09, 0x00, 0x13, 0x07, 0x02, 0x84, 0x05, 0x25, 0x17, 0x53
,2020-03-03 13:22:26.013 Info, Node007, Encrypted Flag is 0
,  z2m:Zwave Notification from node 7: Notification - NoOperation (2) +32ms
,2020-03-03 13:22:26.021 Detail, Node007,   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
,2020-03-03 13:22:26.021 Detail, Node007,   ZW_SEND_DATA delivered to Z-Wave stack
,2020-03-03 13:22:26.041 Detail, Node007,   Received: 0x01, 0x18, 0x00, 0x13, 0x17, 0x00, 0x00, 0x02, 0x00, 0xcf, 0x7f, 0x7f, 0x7f, 0x7f, 0x00, 0x00, 0x03, 0x00, 0x00, 0x00, 0x00, 0x03, 0x01, 0x00, 0x00, 0x2f
,2020-03-03 13:22:26.041 Detail, Node007,   ZW_SEND_DATA Request with callback ID 0x17 received (expected 0x17)
,2020-03-03 13:22:26.042 Info, Node007, Request RTT 28 Average Request RTT 28
,2020-03-03 13:22:26.042 Detail, Node007, Extended TxStatus: Time: 20, Hops: 0, Rssi:  -49 --- --- --- ---, AckChannel: 0, TxChannel: 0, RouteScheme: Last Working Route, Route: 0 0 0 0, RouteSpeed: 100K, RouteTries: 1, FailedLinkFrom: 0, FailedLinkTo: 0
,2020-03-03 13:22:26.042 Detail, Node007,   Expected callbackId was received
,2020-03-03 13:22:26.053 Detail, Node007,   Received: 0x01, 0x0e, 0x00, 0x04, 0x00, 0x07, 0x06, 0x84, 0x06, 0x01, 0x51, 0x80, 0xff, 0xcf, 0x00, 0x96
,2020-03-03 13:22:26.054 Detail, 
,2020-03-03 13:22:26.054 Info, Node007, Response RTT 40 Average Response RTT 40
,2020-03-03 13:22:26.055 Info, Node007, Received Wakeup Interval report from node 7: Interval=86400, Target Node=255
,2020-03-03 13:22:26.055 Detail, Node007, Queuing (WakeUp) WakeUpCmd_IntervalSet (Node=7): 0x01, 0x0d, 0x00, 0x13, 0x07, 0x06, 0x84, 0x04, 0x01, 0x51, 0x80, 0x01, 0x25, 0x18, 0x8c
,2020-03-03 13:22:26.055 Detail, Node007,   Expected reply and command class was received
,2020-03-03 13:22:26.056 Detail, Node007,   Message transaction complete
,2020-03-03 13:22:26.056 Detail, 
,2020-03-03 13:22:26.056 Detail, Node007, Removing current message
,2020-03-03 13:22:26.057 Detail, 
,2020-03-03 13:22:26.057 Info, Node007, Sending (WakeUp) message (Callback ID=0x18, Expected Reply=0x13) - WakeUpCmd_IntervalSet (Node=7): 0x01, 0x0d, 0x00, 0x13, 0x07, 0x06, 0x84, 0x04, 0x01, 0x51, 0x80, 0x01, 0x25, 0x18, 0x8c
,2020-03-03 13:22:26.057 Info, Node007, Encrypted Flag is 0
,2020-03-03 13:22:26.066 Detail, Node007,   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
,2020-03-03 13:22:26.066 Detail, Node007,   ZW_SEND_DATA delivered to Z-Wave stack
,2020-03-03 13:22:26.086 Detail, Node007,   Received: 0x01, 0x18, 0x00, 0x13, 0x18, 0x00, 0x00, 0x02, 0x00, 0xcf, 0x7f, 0x7f, 0x7f, 0x7f, 0x00, 0x00, 0x03, 0x00, 0x00, 0x00, 0x00, 0x03, 0x01, 0x00, 0x00, 0x20
,2020-03-03 13:22:26.087 Detail, Node007,   ZW_SEND_DATA Request with callback ID 0x18 received (expected 0x18)
,2020-03-03 13:22:26.087 Info, Node007, Request RTT 28 Average Request RTT 28
,2020-03-03 13:22:26.087 Detail, Node007, Extended TxStatus: Time: 20, Hops: 0, Rssi:  -49 --- --- --- ---, AckChannel: 0, TxChannel: 0, RouteScheme: Last Working Route, Route: 0 0 0 0, RouteSpeed: 100K, RouteTries: 1, FailedLinkFrom: 0, FailedLinkTo: 0
,2020-03-03 13:22:26.087 Detail, Node007,   Expected callbackId was received
,2020-03-03 13:22:26.087 Detail, Node007,   Expected reply was received
,2020-03-03 13:22:26.087 Detail, Node007,   Message transaction complete
,2020-03-03 13:22:26.087 Detail, 
,2020-03-03 13:22:26.087 Detail, Node007, Removing current message
,2020-03-03 13:22:26.087 Detail, Node007, Query Stage Complete (WakeUp)
,2020-03-03 13:22:26.087 Detail, Node007, AdvanceQueries queryPending=0 queryRetries=0 queryStage=NodeInfo live=1
,2020-03-03 13:22:26.087 Info, Node007, NodeInfo Stage - NodeInfoRecieved 1 - NotInfoSupported 1
,2020-03-03 13:22:26.087 Detail, Node007, QueryStage_NodePlusInfo
,2020-03-03 13:22:26.087 Detail, Node007, Queuing (Query) ZWavePlusInfoCmd_Get (Node=7): 0x01, 0x09, 0x00, 0x13, 0x07, 0x02, 0x5e, 0x01, 0x25, 0x19, 0x83
,2020-03-03 13:22:26.087 Detail, Node007, Queuing (Query) Query Stage Complete (NodePlusInfo)
,2020-03-03 13:22:26.088 Detail, 
,2020-03-03 13:22:26.088 Info, Node007, Sending (Query) message (Callback ID=0x19, Expected Reply=0x04) - ZWavePlusInfoCmd_Get (Node=7): 0x01, 0x09, 0x00, 0x13, 0x07, 0x02, 0x5e, 0x01, 0x25, 0x19, 0x83
,2020-03-03 13:22:26.088 Info, Node007, Encrypted Flag is 0
,2020-03-03 13:22:26.095 Detail, Node007,   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
,2020-03-03 13:22:26.095 Detail, Node007,   ZW_SEND_DATA delivered to Z-Wave stack
,2020-03-03 13:22:26.115 Detail, Node007,   Received: 0x01, 0x18, 0x00, 0x13, 0x19, 0x00, 0x00, 0x02, 0x00, 0xcf, 0x7f, 0x7f, 0x7f, 0x7f, 0x00, 0x00, 0x03, 0x00, 0x00, 0x00, 0x00, 0x03, 0x01, 0x00, 0x00, 0x21
,2020-03-03 13:22:26.115 Detail, Node007,   ZW_SEND_DATA Request with callback ID 0x19 received (expected 0x19)
,2020-03-03 13:22:26.115 Info, Node007, Request RTT 27 Average Request RTT 27
,2020-03-03 13:22:26.116 Detail, Node007, Extended TxStatus: Time: 20, Hops: 0, Rssi:  -49 --- --- --- ---, AckChannel: 0, TxChannel: 0, RouteScheme: Last Working Route, Route: 0 0 0 0, RouteSpeed: 100K, RouteTries: 1, FailedLinkFrom: 0, FailedLinkTo: 0
,2020-03-03 13:22:26.116 Detail, Node007,   Expected callbackId was received
,2020-03-03 13:22:26.128 Detail, Node007,   Received: 0x01, 0x11, 0x00, 0x04, 0x00, 0x07, 0x09, 0x5e, 0x02, 0x01, 0x06, 0x00, 0x0c, 0x06, 0x0c, 0x06, 0xcf, 0x00, 0x70
,2020-03-03 13:22:26.128 Detail, 
,2020-03-03 13:22:26.128 Info, Node007, Response RTT 40 Average Response RTT 40
,2020-03-03 13:22:26.128 Info, Node007, ZW+ Info - Version 1, Role 6, NodeType 0, InstallerIcon 3078, deviceType 3078
,2020-03-03 13:22:26.128 Info, Node007, ZWave+ Info Received from Node 7
,2020-03-03 13:22:26.128 Info, Node007,   Zwave+ Node Type  (0x00) - Z-Wave+ node. Mandatory Command Classes:
,2020-03-03 13:22:26.128 Info, Node007,     NONE
,2020-03-03 13:22:26.128 Info, Node007,   Zwave+ Device Type  (0x0c06) - Access Control Sensor. Mandatory Command Classes:
,2020-03-03 13:22:26.128 Info, Node007,     COMMAND_CLASS_DEVICE_RESET_LOCALLY
,2020-03-03 13:22:26.128 Info, Node007,     COMMAND_CLASS_ZWAVEPLUS_INFO
,2020-03-03 13:22:26.128 Info, Node007,     0x59 (Not Supported)
,2020-03-03 13:22:26.128 Info, Node007,     COMMAND_CLASS_MANUFACTURER_SPECIFIC
,2020-03-03 13:22:26.128 Info, Node007,     COMMAND_CLASS_POWERLEVEL
,2020-03-03 13:22:26.129 Info, Node007,     COMMAND_CLASS_ASSOCIATION
,2020-03-03 13:22:26.129 Info, Node007,     COMMAND_CLASS_VERSION
,2020-03-03 13:22:26.129 Info, Node007,     COMMAND_CLASS_SENSOR_BINARY
,2020-03-03 13:22:26.129 Info, Node007,   ZWave+ Role Type  (0x06) - Reporting Sleeping Slave
,2020-03-03 13:22:26.129 Info, Node007,     COMMAND_CLASS_DEVICE_RESET_LOCALLY
,2020-03-03 13:22:26.129 Info, Node007,     COMMAND_CLASS_WAKE_UP
,2020-03-03 13:22:26.129 Detail, Node007,   Expected reply and command class was received
,2020-03-03 13:22:26.129 Detail, Node007,   Message transaction complete
,2020-03-03 13:22:26.129 Detail, 
,2020-03-03 13:22:26.129 Detail, Node007, Removing current message
,2020-03-03 13:22:26.129 Detail, Node007, Query Stage Complete (NodePlusInfo)
,2020-03-03 13:22:26.129 Detail, Node007, AdvanceQueries queryPending=0 queryRetries=0 queryStage=SecurityReport live=1
,2020-03-03 13:22:26.129 Detail, Node007, QueryStage_SecurityReport
,2020-03-03 13:22:26.129 Detail, Node007, QueryStage_Versions
,2020-03-03 13:22:26.129 Info, Node007, Requesting Versions
,2020-03-03 13:22:26.129 Info, Node007, Requesting Versions for COMMAND_CLASS_NO_OPERATION - Max: 1 - Current 0
,2020-03-03 13:22:26.129 Info, Node007, Requesting Versions for COMMAND_CLASS_BASIC - Max: 1 - Current 0
,2020-03-03 13:22:26.129 Info, Node007, Requesting Versions for COMMAND_CLASS_SENSOR_BINARY - Max: 1 - Current 0
,2020-03-03 13:22:26.129 Info, Node007, Requesting Versions for COMMAND_CLASS_DEVICE_RESET_LOCALLY - Max: 1 - Current 0
,2020-03-03 13:22:26.129 Info, Node007, Requesting Versions for COMMAND_CLASS_ZWAVEPLUS_INFO - Max: 1 - Current 0
,2020-03-03 13:22:26.129 Info, Node007, Requesting Versions for COMMAND_CLASS_CONFIGURATION - Max: 1 - Current 0
,2020-03-03 13:22:26.129 Info, Node007, Requesting Versions for COMMAND_CLASS_NOTIFICATION - Max: 8 - Current 0
,2020-03-03 13:22:26.129 Detail, Node007, Queuing (Query) VersionCmd_CommandClassGet (Node=7): 0x01, 0x0a, 0x00, 0x13, 0x07, 0x03, 0x86, 0x13, 0x71, 0x25, 0x1a, 0x39
,2020-03-03 13:22:26.129 Info, Node007, Requesting Versions for COMMAND_CLASS_MANUFACTURER_SPECIFIC - Max: 2 - Current 0
,2020-03-03 13:22:26.129 Detail, Node007, Queuing (Query) VersionCmd_CommandClassGet (Node=7): 0x01, 0x0a, 0x00, 0x13, 0x07, 0x03, 0x86, 0x13, 0x72, 0x25, 0x1b, 0x3b
,2020-03-03 13:22:26.129 Info, Node007, Requesting Versions for COMMAND_CLASS_POWERLEVEL - Max: 1 - Current 0
,2020-03-03 13:22:26.129 Info, Node007, Requesting Versions for COMMAND_CLASS_BATTERY - Max: 1 - Current 0
,2020-03-03 13:22:26.129 Info, Node007, Requesting Versions for COMMAND_CLASS_WAKE_UP - Max: 2 - Current 0
,2020-03-03 13:22:26.129 Detail, Node007, Queuing (Query) VersionCmd_CommandClassGet (Node=7): 0x01, 0x0a, 0x00, 0x13, 0x07, 0x03, 0x86, 0x13, 0x84, 0x25, 0x1c, 0xca
,2020-03-03 13:22:26.129 Info, Node007, Requesting Versions for COMMAND_CLASS_ASSOCIATION - Max: 1 - Current 0
,2020-03-03 13:22:26.129 Info, Node007, Requesting Versions for COMMAND_CLASS_VERSION - Max: 1 - Current 0
,2020-03-03 13:22:26.129 Detail, Node007, Queuing (Query) Query Stage Complete (Versions)
,2020-03-03 13:22:26.129 Detail, 
,2020-03-03 13:22:26.129 Info, Node007, Sending (Query) message (Callback ID=0x1a, Expected Reply=0x04) - VersionCmd_CommandClassGet (Node=7): 0x01, 0x0a, 0x00, 0x13, 0x07, 0x03, 0x86, 0x13, 0x71, 0x25, 0x1a, 0x39
,2020-03-03 13:22:26.130 Info, Node007, Encrypted Flag is 0
,2020-03-03 13:22:26.138 Detail, Node007,   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
,2020-03-03 13:22:26.138 Detail, Node007,   ZW_SEND_DATA delivered to Z-Wave stack
,2020-03-03 13:22:26.158 Detail, Node007,   Received: 0x01, 0x18, 0x00, 0x13, 0x1a, 0x00, 0x00, 0x02, 0x00, 0xd0, 0x7f, 0x7f, 0x7f, 0x7f, 0x00, 0x00, 0x03, 0x00, 0x00, 0x00, 0x00, 0x03, 0x01, 0x00, 0x00, 0x3d
,2020-03-03 13:22:26.158 Detail, Node007,   ZW_SEND_DATA Request with callback ID 0x1a received (expected 0x1a)
,2020-03-03 13:22:26.158 Info, Node007, Request RTT 28 Average Request RTT 27
,2020-03-03 13:22:26.158 Detail, Node007, Extended TxStatus: Time: 20, Hops: 0, Rssi:  -48 --- --- --- ---, AckChannel: 0, TxChannel: 0, RouteScheme: Last Working Route, Route: 0 0 0 0, RouteSpeed: 100K, RouteTries: 1, FailedLinkFrom: 0, FailedLinkTo: 0
,2020-03-03 13:22:26.158 Detail, Node007,   Expected callbackId was received
,2020-03-03 13:22:26.171 Detail, Node007,   Received: 0x01, 0x0c, 0x00, 0x04, 0x00, 0x07, 0x04, 0x86, 0x14, 0x71, 0x04, 0xcf, 0x00, 0xdc
,2020-03-03 13:22:26.171 Detail, 
,2020-03-03 13:22:26.171 Info, Node007, Response RTT 41 Average Response RTT 40
,2020-03-03 13:22:26.171 Info, Node007, Received CommandClass Version report from node 7: CommandClass=COMMAND_CLASS_NOTIFICATION, Version=4
,2020-03-03 13:22:26.171 Detail, Node007,   Expected reply and command class was received
,2020-03-03 13:22:26.171 Detail, Node007,   Message transaction complete
,2020-03-03 13:22:26.171 Detail, 
,2020-03-03 13:22:26.171 Detail, Node007, Removing current message
,2020-03-03 13:22:26.171 Detail, 
,2020-03-03 13:22:26.171 Info, Node007, Sending (Query) message (Callback ID=0x1b, Expected Reply=0x04) - VersionCmd_CommandClassGet (Node=7): 0x01, 0x0a, 0x00, 0x13, 0x07, 0x03, 0x86, 0x13, 0x72, 0x25, 0x1b, 0x3b
,2020-03-03 13:22:26.171 Info, Node007, Encrypted Flag is 0
,2020-03-03 13:22:26.180 Detail, Node007,   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
,2020-03-03 13:22:26.180 Detail, Node007,   ZW_SEND_DATA delivered to Z-Wave stack
,2020-03-03 13:22:26.200 Detail, Node007,   Received: 0x01, 0x18, 0x00, 0x13, 0x1b, 0x00, 0x00, 0x02, 0x00, 0xcf, 0x7f, 0x7f, 0x7f, 0x7f, 0x00, 0x00, 0x03, 0x00, 0x00, 0x00, 0x00, 0x03, 0x01, 0x00, 0x00, 0x23
,2020-03-03 13:22:26.200 Detail, Node007,   ZW_SEND_DATA Request with callback ID 0x1b received (expected 0x1b)
,2020-03-03 13:22:26.200 Info, Node007, Request RTT 29 Average Request RTT 28
,2020-03-03 13:22:26.201 Detail, Node007, Extended TxStatus: Time: 20, Hops: 0, Rssi:  -49 --- --- --- ---, AckChannel: 0, TxChannel: 0, RouteScheme: Last Working Route, Route: 0 0 0 0, RouteSpeed: 100K, RouteTries: 1, FailedLinkFrom: 0, FailedLinkTo: 0
,2020-03-03 13:22:26.201 Detail, Node007,   Expected callbackId was received
,2020-03-03 13:22:26.213 Detail, Node007,   Received: 0x01, 0x0c, 0x00, 0x04, 0x00, 0x07, 0x04, 0x86, 0x14, 0x72, 0x02, 0xcf, 0x00, 0xd9
,2020-03-03 13:22:26.213 Detail, 
,2020-03-03 13:22:26.213 Info, Node007, Response RTT 41 Average Response RTT 40
,2020-03-03 13:22:26.213 Info, Node007, Received CommandClass Version report from node 7: CommandClass=COMMAND_CLASS_MANUFACTURER_SPECIFIC, Version=2
,2020-03-03 13:22:26.213 Detail, Node007,   Expected reply and command class was received
,2020-03-03 13:22:26.213 Detail, Node007,   Message transaction complete
,2020-03-03 13:22:26.213 Detail, 
,2020-03-03 13:22:26.213 Detail, Node007, Removing current message
,2020-03-03 13:22:26.213 Detail, 
,2020-03-03 13:22:26.213 Info, Node007, Sending (Query) message (Callback ID=0x1c, Expected Reply=0x04) - VersionCmd_CommandClassGet (Node=7): 0x01, 0x0a, 0x00, 0x13, 0x07, 0x03, 0x86, 0x13, 0x84, 0x25, 0x1c, 0xca
,2020-03-03 13:22:26.213 Info, Node007, Encrypted Flag is 0
,2020-03-03 13:22:26.222 Detail, Node007,   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
,2020-03-03 13:22:26.222 Detail, Node007,   ZW_SEND_DATA delivered to Z-Wave stack
,2020-03-03 13:22:26.243 Detail, Node007,   Received: 0x01, 0x18, 0x00, 0x13, 0x1c, 0x00, 0x00, 0x02, 0x00, 0xcf, 0x7f, 0x7f, 0x7f, 0x7f, 0x00, 0x00, 0x03, 0x00, 0x00, 0x00, 0x00, 0x03, 0x01, 0x00, 0x00, 0x24
,2020-03-03 13:22:26.243 Detail, Node007,   ZW_SEND_DATA Request with callback ID 0x1c received (expected 0x1c)
,2020-03-03 13:22:26.243 Info, Node007, Request RTT 29 Average Request RTT 28
,2020-03-03 13:22:26.243 Detail, Node007, Extended TxStatus: Time: 20, Hops: 0, Rssi:  -49 --- --- --- ---, AckChannel: 0, TxChannel: 0, RouteScheme: Last Working Route, Route: 0 0 0 0, RouteSpeed: 100K, RouteTries: 1, FailedLinkFrom: 0, FailedLinkTo: 0
,2020-03-03 13:22:26.243 Detail, Node007,   Expected callbackId was received
,2020-03-03 13:22:26.255 Detail, Node007,   Received: 0x01, 0x0c, 0x00, 0x04, 0x00, 0x07, 0x04, 0x86, 0x14, 0x84, 0x02, 0xcf, 0x00, 0x2f
,2020-03-03 13:22:26.256 Detail, 
,2020-03-03 13:22:26.256 Info, Node007, Response RTT 42 Average Response RTT 41
,2020-03-03 13:22:26.256 Info, Node007, Received CommandClass Version report from node 7: CommandClass=COMMAND_CLASS_WAKE_UP, Version=2
,2020-03-03 13:22:26.256 Detail, Node007,   Expected reply and command class was received
,2020-03-03 13:22:26.256 Detail, Node007,   Message transaction complete
,2020-03-03 13:22:26.256 Detail, 
,2020-03-03 13:22:26.256 Detail, Node007, Removing current message
,2020-03-03 13:22:26.256 Detail, Node007, Query Stage Complete (Versions)
,2020-03-03 13:22:26.256 Detail, Node007, AdvanceQueries queryPending=0 queryRetries=0 queryStage=ManufacturerSpecific1 live=1
,2020-03-03 13:22:26.256 Detail, Node007, QueryStage_ManufacturerSpecific1
,2020-03-03 13:22:26.256 Detail, Node007, Checking for ManufacturerSpecific CC and Requesting values if present on this node
,2020-03-03 13:22:26.256 Detail, Node007, Queuing (Query) ManufacturerSpecificCmd_Get (Node=7): 0x01, 0x09, 0x00, 0x13, 0x07, 0x02, 0x72, 0x04, 0x25, 0x1d, 0xae
,2020-03-03 13:22:26.256 Detail, Node007, Queuing (Query) Query Stage Complete (ManufacturerSpecific1)
,2020-03-03 13:22:26.257 Detail, 
,2020-03-03 13:22:26.257 Info, Node007, Sending (Query) message (Callback ID=0x1d, Expected Reply=0x04) - ManufacturerSpecificCmd_Get (Node=7): 0x01, 0x09, 0x00, 0x13, 0x07, 0x02, 0x72, 0x04, 0x25, 0x1d, 0xae
,2020-03-03 13:22:26.257 Info, Node007, Encrypted Flag is 0
,2020-03-03 13:22:26.265 Detail, Node007,   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
,2020-03-03 13:22:26.265 Detail, Node007,   ZW_SEND_DATA delivered to Z-Wave stack
,2020-03-03 13:22:26.285 Detail, Node007,   Received: 0x01, 0x18, 0x00, 0x13, 0x1d, 0x00, 0x00, 0x02, 0x00, 0xcf, 0x7f, 0x7f, 0x7f, 0x7f, 0x00, 0x00, 0x03, 0x00, 0x00, 0x00, 0x00, 0x03, 0x01, 0x00, 0x00, 0x25
,2020-03-03 13:22:26.285 Detail, Node007,   ZW_SEND_DATA Request with callback ID 0x1d received (expected 0x1d)
,2020-03-03 13:22:26.285 Info, Node007, Request RTT 28 Average Request RTT 28
,2020-03-03 13:22:26.285 Detail, Node007, Extended TxStatus: Time: 20, Hops: 0, Rssi:  -49 --- --- --- ---, AckChannel: 0, TxChannel: 0, RouteScheme: Last Working Route, Route: 0 0 0 0, RouteSpeed: 100K, RouteTries: 1, FailedLinkFrom: 0, FailedLinkTo: 0
,2020-03-03 13:22:26.285 Detail, Node007,   Expected callbackId was received
,2020-03-03 13:22:26.298 Detail, Node007,   Received: 0x01, 0x10, 0x00, 0x04, 0x00, 0x07, 0x08, 0x72, 0x05, 0x02, 0x14, 0x00, 0x02, 0x00, 0x01, 0xcf, 0x00, 0x49
,2020-03-03 13:22:26.298 Detail, 
,2020-03-03 13:22:26.298 Info, Node007, Response RTT 41 Average Response RTT 41
,2020-03-03 13:22:26.298 Info, Node007,   Opening config param file /usr/local/etc/openzwave/kaipule/im20.xml
,2020-03-03 13:22:26.299 Info, Node007, Queuing Lookup on 0001.0002.0214.db.openzwave.com for Node 7
,2020-03-03 13:22:26.299 Info, Node007,   Configuration File Revision is 3
,2020-03-03 13:22:26.299 Info, Node007, (112 - COMMAND_CLASS_CONFIGURATION) - Compatibility Flags:
,2020-03-03 13:22:26.299 Info, Node007, (112 - COMMAND_CLASS_CONFIGURATION) - State Flags:
,2020-03-03 13:22:26.300 Info, Node007,      CCVersion: 1
,2020-03-03 13:22:26.300 Info, Node007,      InNif: true
,2020-03-03 13:22:26.300 Info, Node007,      StaticRequests: 4
,2020-03-03 13:22:26.300 Info, LookupTxT Checking 0001.0002.0214.db.openzwave.com
,2020-03-03 13:22:26.300 Info, Node007, (133 - COMMAND_CLASS_ASSOCIATION) - Compatibility Flags:
,2020-03-03 13:22:26.300 Info, Node007, (133 - COMMAND_CLASS_ASSOCIATION) - State Flags:
,2020-03-03 13:22:26.300 Info, Node007,      CCVersion: 1
,2020-03-03 13:22:26.300 Info, Node007,      InNif: true
,2020-03-03 13:22:26.300 Info, Node007,      StaticRequests: 6
,2020-03-03 13:22:26.301 Info, Node007, Received manufacturer specific report from node 7: Manufacturer=Kaipule Technology Co. Ltd, Product=IM20 Door/Window Sensor
,2020-03-03 13:22:26.301 Info, Node007, Node Identity Codes: 0214:0002:0001
,2020-03-03 13:22:26.301 Detail, Node007,   Expected reply and command class was received
,2020-03-03 13:22:26.301 Detail, Node007,   Message transaction complete
,2020-03-03 13:22:26.301 Detail, 
,2020-03-03 13:22:26.301 Detail, Node007, Removing current message
,2020-03-03 13:22:26.301 Detail, Node007, Notification: ValueAdded CC: COMMAND_CLASS_CONFIGURATION Instance: 1 Index: 1
,2020-03-03 13:22:26.301 Detail, Node007, Notification: ValueAdded CC: COMMAND_CLASS_CONFIGURATION Instance: 1 Index: 2
,2020-03-03 13:22:26.301 Detail, Node007, Notification: ValueAdded CC: COMMAND_CLASS_CONFIGURATION Instance: 1 Index: 3
,2020-03-03 13:22:26.301 Detail, Node007, Notification: Group
,2020-03-03 13:22:26.301 Detail, Node007, Notification: Group
,2020-03-03 13:22:26.301 Detail, Node007, Notification: NodeNaming
,2020-03-03 13:22:26.302 Detail, Node007, Query Stage Complete (ManufacturerSpecific1)
,2020-03-03 13:22:26.302 Detail, Node007, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Instances live=1
,2020-03-03 13:22:26.302 Detail, Node007, QueryStage_Instances
,2020-03-03 13:22:26.302 Info, Node007, Essential node queries are complete
,2020-03-03 13:22:26.302 Info, Node007,   Opening config param file /usr/local/etc/openzwave/kaipule/im20.xml
,2020-03-03 13:22:26.302 Info, Lookup for 0001.0002.0214.db.openzwave.com returned 3
,2020-03-03 13:22:26.303 Info, Node007, (112 - COMMAND_CLASS_CONFIGURATION) - Compatibility Flags:
,2020-03-03 13:22:26.303 Info, Node007, (112 - COMMAND_CLASS_CONFIGURATION) - State Flags:
,2020-03-03 13:22:26.303 Info, Node007,      CCVersion: 1
,2020-03-03 13:22:26.303 Info, Node007,      InNif: true
,2020-03-03 13:22:26.303 Info, Node007,      StaticRequests: 4
,  z2m:Zwave ValueAdded: 7-112-1-1 Basic Set Level +289ms
,2020-03-03 13:22:26.303 Info, Node007, (133 - COMMAND_CLASS_ASSOCIATION) - Compatibility Flags:
,2020-03-03 13:22:26.303 Info, Node007, (133 - COMMAND_CLASS_ASSOCIATION) - State Flags:
,2020-03-03 13:22:26.303 Info, Node007,      CCVersion: 1
,2020-03-03 13:22:26.303 Info, Node007,      InNif: true
,2020-03-03 13:22:26.303 Info, Node007,      StaticRequests: 6
,2020-03-03 13:22:26.304 Detail, Node007, QueryStage_Static
,2020-03-03 13:22:26.304 Info, Node007, Creating ValueIDs for Instance 1 on COMMAND_CLASS_BASIC
,2020-03-03 13:22:26.304 Info, Node007, COMMAND_CLASS_BASIC is not mapped to another CC. Exposing ValueID
,2020-03-03 13:22:26.304 Info, Node007, Creating ValueIDs for Instance 1 on COMMAND_CLASS_SENSOR_BINARY
,2020-03-03 13:22:26.304 Info, Node007, Creating ValueIDs for Instance 1 on COMMAND_CLASS_DEVICE_RESET_LOCALLY
,2020-03-03 13:22:26.304 Info, Node007, Creating ValueIDs for Instance 1 on COMMAND_CLASS_ZWAVE_PLUS_INFO
,2020-03-03 13:22:26.304 Detail, Node007, Queuing (Query) ZWavePlusInfoCmd_Get (Node=7): 0x01, 0x09, 0x00, 0x13, 0x07, 0x02, 0x5e, 0x01, 0x25, 0x1e, 0x84
,2020-03-03 13:22:26.304 Info, Node007, Creating ValueIDs for Instance 1 on COMMAND_CLASS_CONFIGURATION
,2020-03-03 13:22:26.304 Info, Node007, Creating ValueIDs for Instance 1 on COMMAND_CLASS_NOTIFICATION
,2020-03-03 13:22:26.304 Detail, Node007, Queuing (Query) AlarmCmd_SupportedGet (Node=7): 0x01, 0x09, 0x00, 0x13, 0x07, 0x02, 0x71, 0x07, 0x25, 0x1f, 0xac
,2020-03-03 13:22:26.305 Info, Node007, Creating ValueIDs for Instance 1 on COMMAND_CLASS_MANUFACTURER_SPECIFIC
,2020-03-03 13:22:26.305 Detail, Node007, Queuing (Query) ManufacturerSpecificCmd_DeviceGet_DeviceIDType_FactoryDefault (Node=7): 0x01, 0x0a, 0x00, 0x13, 0x07, 0x03, 0x72, 0x06, 0x00, 0x25, 0x20, 0x93
,2020-03-03 13:22:26.305 Detail, Node007, Queuing (Query) ManufacturerSpecificCmd_DeviceGet_DeviceIDType_SerialNumber (Node=7): 0x01, 0x0a, 0x00, 0x13, 0x07, 0x03, 0x72, 0x06, 0x01, 0x25, 0x21, 0x93
,2020-03-03 13:22:26.305 Info, Node007, Creating ValueIDs for Instance 1 on COMMAND_CLASS_POWERLEVEL
,  z2m:Zwave ValueAdded: 7-112-1-2 Turn Off Light Time +2ms
,2020-03-03 13:22:26.305 Info, Node007, Creating ValueIDs for Instance 1 on COMMAND_CLASS_BATTERY
,2020-03-03 13:22:26.305 Info, Node007, Creating ValueIDs for Instance 1 on COMMAND_CLASS_WAKE_UP
,2020-03-03 13:22:26.305 Detail, Node007, Initial read of value
,2020-03-03 13:22:26.305 Detail, Node007, Queuing (Query) WakeUpCmd_IntervalCapabilityGet (Node=7): 0x01, 0x09, 0x00, 0x13, 0x07, 0x02, 0x84, 0x09, 0x25, 0x22, 0x6a
,2020-03-03 13:22:26.305 Info, Node007, Creating ValueIDs for Instance 1 on COMMAND_CLASS_ASSOCIATION
,2020-03-03 13:22:26.305 Detail, Node007, Queuing (Query) AssociationCmd_GroupingsGet (Node=7): 0x01, 0x09, 0x00, 0x13, 0x07, 0x02, 0x85, 0x05, 0x25, 0x23, 0x66
,2020-03-03 13:22:26.305 Info, Node007, Creating ValueIDs for Instance 1 on COMMAND_CLASS_VERSION
,2020-03-03 13:22:26.306 Detail, Node007, Queuing (Query) VersionCmd_Get (Node=7): 0x01, 0x09, 0x00, 0x13, 0x07, 0x02, 0x86, 0x11, 0x25, 0x24, 0x76
,2020-03-03 13:22:26.306 Detail, Node007, Queuing (Query) Query Stage Complete (Static)
,2020-03-03 13:22:26.306 Detail, Node007, Notification: EssentialNodeQueriesComplete
,2020-03-03 13:22:26.306 Detail, Node007, Notification: Group
,2020-03-03 13:22:26.306 Detail, Node007, Notification: Group
,2020-03-03 13:22:26.306 Detail, Node007, Notification: ValueAdded CC: COMMAND_CLASS_BASIC Instance: 1 Index: 0
,2020-03-03 13:22:26.306 Detail, Node007, Notification: ValueAdded CC: COMMAND_CLASS_SENSOR_BINARY Instance: 1 Index: 0
,2020-03-03 13:22:26.306 Detail, Node007, Notification: ValueAdded CC: COMMAND_CLASS_ZWAVEPLUS_INFO Instance: 1 Index: 0
,2020-03-03 13:22:26.306 Detail, Node007, Notification: ValueAdded CC: COMMAND_CLASS_ZWAVEPLUS_INFO Instance: 1 Index: 1
,2020-03-03 13:22:26.306 Detail, Node007, Notification: ValueAdded CC: COMMAND_CLASS_ZWAVEPLUS_INFO Instance: 1 Index: 2
,2020-03-03 13:22:26.306 Detail, Node007, Notification: ValueAdded CC: COMMAND_CLASS_MANUFACTURER_SPECIFIC Instance: 1 Index: 0
,2020-03-03 13:22:26.306 Detail, Node007, Notification: ValueAdded CC: COMMAND_CLASS_MANUFACTURER_SPECIFIC Instance: 1 Index: 1
,2020-03-03 13:22:26.307 Detail, Node007, Notification: ValueAdded CC: COMMAND_CLASS_MANUFACTURER_SPECIFIC Instance: 1 Index: 2
,2020-03-03 13:22:26.307 Detail, Node007, Notification: ValueAdded CC: COMMAND_CLASS_MANUFACTURER_SPECIFIC Instance: 1 Index: 3
,  z2m:Zwave ValueAdded: 7-112-1-3 Auto report status time +1ms
,2020-03-03 13:22:26.307 Detail, Node007, Notification: ValueAdded CC: COMMAND_CLASS_MANUFACTURER_SPECIFIC Instance: 1 Index: 4
,2020-03-03 13:22:26.307 Detail, Node007, Notification: ValueAdded CC: COMMAND_CLASS_POWERLEVEL Instance: 1 Index: 0
,2020-03-03 13:22:26.307 Detail, Node007, Notification: ValueAdded CC: COMMAND_CLASS_POWERLEVEL Instance: 1 Index: 1
,2020-03-03 13:22:26.307 Detail, Node007, Notification: ValueAdded CC: COMMAND_CLASS_POWERLEVEL Instance: 1 Index: 2
,2020-03-03 13:22:26.307 Detail, Node007, Notification: ValueAdded CC: COMMAND_CLASS_POWERLEVEL Instance: 1 Index: 3
,2020-03-03 13:22:26.307 Detail, Node007, Notification: ValueAdded CC: COMMAND_CLASS_POWERLEVEL Instance: 1 Index: 4
,2020-03-03 13:22:26.307 Detail, Node007, Notification: ValueAdded CC: COMMAND_CLASS_POWERLEVEL Instance: 1 Index: 5
,2020-03-03 13:22:26.307 Detail, Node007, Notification: ValueAdded CC: COMMAND_CLASS_POWERLEVEL Instance: 1 Index: 6
,2020-03-03 13:22:26.307 Detail, Node007, Notification: ValueAdded CC: COMMAND_CLASS_POWERLEVEL Instance: 1 Index: 7
,2020-03-03 13:22:26.307 Detail, Node007, Notification: ValueAdded CC: COMMAND_CLASS_POWERLEVEL Instance: 1 Index: 8
,2020-03-03 13:22:26.307 Detail, Node007, Notification: ValueAdded CC: COMMAND_CLASS_POWERLEVEL Instance: 1 Index: 9
,2020-03-03 13:22:26.308 Detail, Node007, Notification: ValueAdded CC: COMMAND_CLASS_BATTERY Instance: 1 Index: 0
,2020-03-03 13:22:26.308 Detail, Node007, Notification: ValueAdded CC: COMMAND_CLASS_WAKE_UP Instance: 1 Index: 1
,2020-03-03 13:22:26.308 Detail, Node007, Notification: ValueAdded CC: COMMAND_CLASS_WAKE_UP Instance: 1 Index: 2
,2020-03-03 13:22:26.308 Detail, Node007, Notification: ValueAdded CC: COMMAND_CLASS_WAKE_UP Instance: 1 Index: 3
,2020-03-03 13:22:26.308 Detail, Node007, Notification: ValueAdded CC: COMMAND_CLASS_WAKE_UP Instance: 1 Index: 4
,2020-03-03 13:22:26.308 Detail, Node007, Notification: ValueAdded CC: COMMAND_CLASS_WAKE_UP Instance: 1 Index: 0
,2020-03-03 13:22:26.308 Detail, Node007, Notification: ValueChanged CC: COMMAND_CLASS_WAKE_UP Instance: 1 Index: 0
,2020-03-03 13:22:26.308 Detail, Node007, Notification: ValueAdded CC: COMMAND_CLASS_VERSION Instance: 1 Index: 0
,2020-03-03 13:22:26.308 Detail, Node007, Notification: ValueAdded CC: COMMAND_CLASS_VERSION Instance: 1 Index: 1
,2020-03-03 13:22:26.308 Detail, Node007, Notification: ValueAdded CC: COMMAND_CLASS_VERSION Instance: 1 Index: 2
,2020-03-03 13:22:26.308 Detail, Node007, Initial read of value
,2020-03-03 13:22:26.308 Detail, Node007, Notification: ValueChanged CC: COMMAND_CLASS_MANUFACTURER_SPECIFIC Instance: 1 Index: 2
,2020-03-03 13:22:26.309 Detail, 
,2020-03-03 13:22:26.309 Info, Node007, Sending (Query) message (Callback ID=0x1e, Expected Reply=0x04) - ZWavePlusInfoCmd_Get (Node=7): 0x01, 0x09, 0x00, 0x13, 0x07, 0x02, 0x5e, 0x01, 0x25, 0x1e, 0x84
,2020-03-03 13:22:26.309 Info, Node007, Encrypted Flag is 0
,  z2m:Zwave node 7 AVAILABLE: Kaipule Technology Co. Ltd - IM20 Door/Window Sensor (Access Control Sensor) +2ms
,  z2m:Zwave ValueAdded: 7-32-1-0 Basic +1ms
,  z2m:Zwave ValueAdded: 7-48-1-0 Sensor +2ms
,  z2m:Zwave ValueAdded: 7-94-1-0 ZWave+ Version +1ms
,  z2m:Zwave ValueAdded: 7-94-1-1 InstallerIcon +2ms
,  z2m:Zwave ValueAdded: 7-94-1-2 UserIcon +1ms
,2020-03-03 13:22:26.316 Detail, Node007,   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
,2020-03-03 13:22:26.316 Detail, Node007,   ZW_SEND_DATA delivered to Z-Wave stack
,  z2m:Zwave ValueAdded: 7-114-1-0 Loaded Config Revision +2ms
,  z2m:Zwave ValueAdded: 7-114-1-1 Config File Revision +1ms
,  z2m:Zwave ValueAdded: 7-114-1-2 Latest Available Config File Revision +1ms
,  z2m:Zwave ValueAdded: 7-114-1-3 Device ID +2ms
,  z2m:Zwave ValueAdded: 7-114-1-4 Serial Number +1ms
,  z2m:Zwave ValueAdded: 7-115-1-0 Powerlevel +2ms
,  z2m:Zwave ValueAdded: 7-115-1-1 Timeout +1ms
,  z2m:Zwave ValueAdded: 7-115-1-2 Set Powerlevel +1ms
,  z2m:Zwave ValueAdded: 7-115-1-3 Test Node +1ms
,  z2m:Zwave ValueAdded: 7-115-1-4 Test Powerlevel +1ms
,  z2m:Zwave ValueAdded: 7-115-1-5 Frame Count +2ms
,  z2m:Zwave ValueAdded: 7-115-1-6 Test +2ms
,  z2m:Zwave ValueAdded: 7-115-1-7 Report +1ms
,  z2m:Zwave ValueAdded: 7-115-1-8 Test Status +1ms
,  z2m:Zwave ValueAdded: 7-115-1-9 Acked Frames +0ms
,  z2m:Zwave ValueAdded: 7-128-1-0 Battery Level +1ms
,  z2m:Zwave ValueAdded: 7-132-1-1 Minimum Wake-up Interval +1ms
,  z2m:Zwave ValueAdded: 7-132-1-2 Maximum Wake-up Interval +1ms
,  z2m:Zwave ValueAdded: 7-132-1-3 Default Wake-up Interval +2ms
,2020-03-03 13:22:26.339 Detail, Node007,   Received: 0x01, 0x18, 0x00, 0x13, 0x1e, 0x00, 0x00, 0x02, 0x00, 0xcf, 0x7f, 0x7f, 0x7f, 0x7f, 0x00, 0x00, 0x03, 0x00, 0x00, 0x00, 0x00, 0x03, 0x01, 0x00, 0x00, 0x26
,2020-03-03 13:22:26.339 Detail, Node007,   ZW_SEND_DATA Request with callback ID 0x1e received (expected 0x1e)
,2020-03-03 13:22:26.339 Info, Node007, Request RTT 30 Average Request RTT 29
,2020-03-03 13:22:26.339 Detail, Node007, Extended TxStatus: Time: 20, Hops: 0, Rssi:  -49 --- --- --- ---, AckChannel: 0, TxChannel: 0, RouteScheme: Last Working Route, Route: 0 0 0 0, RouteSpeed: 100K, RouteTries: 1, FailedLinkFrom: 0, FailedLinkTo: 0
,2020-03-03 13:22:26.339 Detail, Node007,   Expected callbackId was received
,  z2m:Zwave ValueAdded: 7-132-1-4 Wake-up Interval Step +2ms
,  z2m:Zwave ValueAdded: 7-132-1-0 Wake-up Interval +1ms
,  z2m:Zwave ValueAdded: 7-134-1-0 Library Version +0ms
,  z2m:Zwave ValueAdded: 7-134-1-1 Protocol Version +1ms
,  z2m:Zwave ValueAdded: 7-134-1-2 Application Version +0ms
,2020-03-03 13:22:26.351 Detail, Node007,   Received: 0x01, 0x11, 0x00, 0x04, 0x00, 0x07, 0x09, 0x5e, 0x02, 0x01, 0x06, 0x00, 0x0c, 0x06, 0x0c, 0x06, 0xcf, 0x00, 0x70
,2020-03-03 13:22:26.351 Detail, 
,2020-03-03 13:22:26.351 Info, Node007, Response RTT 41 Average Response RTT 41
,2020-03-03 13:22:26.351 Info, Node007, ZW+ Info - Version 1, Role 6, NodeType 0, InstallerIcon 3078, deviceType 3078
,2020-03-03 13:22:26.351 Detail, Node007, Initial read of value
,2020-03-03 13:22:26.351 Detail, Node007, Initial read of value
,2020-03-03 13:22:26.351 Detail, Node007, Initial read of value
,2020-03-03 13:22:26.351 Detail, Node007,   Expected reply and command class was received
,2020-03-03 13:22:26.351 Detail, Node007,   Message transaction complete
,2020-03-03 13:22:26.351 Detail, 
,2020-03-03 13:22:26.351 Detail, Node007, Removing current message
,2020-03-03 13:22:26.351 Detail, Node007, Notification: ValueChanged CC: COMMAND_CLASS_ZWAVEPLUS_INFO Instance: 1 Index: 0
,2020-03-03 13:22:26.351 Detail, Node007, Notification: ValueChanged CC: COMMAND_CLASS_ZWAVEPLUS_INFO Instance: 1 Index: 1
,2020-03-03 13:22:26.351 Detail, Node007, Notification: ValueChanged CC: COMMAND_CLASS_ZWAVEPLUS_INFO Instance: 1 Index: 2
,2020-03-03 13:22:26.351 Detail, 
,2020-03-03 13:22:26.351 Info, Node007, Sending (Query) message (Callback ID=0x1f, Expected Reply=0x04) - AlarmCmd_SupportedGet (Node=7): 0x01, 0x09, 0x00, 0x13, 0x07, 0x02, 0x71, 0x07, 0x25, 0x1f, 0xac
,2020-03-03 13:22:26.351 Info, Node007, Encrypted Flag is 0
,2020-03-03 13:22:26.359 Detail, Node007,   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
,2020-03-03 13:22:26.359 Detail, Node007,   ZW_SEND_DATA delivered to Z-Wave stack
,2020-03-03 13:22:26.379 Detail, Node007,   Received: 0x01, 0x18, 0x00, 0x13, 0x1f, 0x00, 0x00, 0x02, 0x00, 0xcf, 0x7f, 0x7f, 0x7f, 0x7f, 0x00, 0x00, 0x03, 0x00, 0x00, 0x00, 0x00, 0x03, 0x01, 0x00, 0x00, 0x27
,2020-03-03 13:22:26.379 Detail, Node007,   ZW_SEND_DATA Request with callback ID 0x1f received (expected 0x1f)
,2020-03-03 13:22:26.380 Info, Node007, Request RTT 28 Average Request RTT 28
,2020-03-03 13:22:26.380 Detail, Node007, Extended TxStatus: Time: 20, Hops: 0, Rssi:  -49 --- --- --- ---, AckChannel: 0, TxChannel: 0, RouteScheme: Last Working Route, Route: 0 0 0 0, RouteSpeed: 100K, RouteTries: 1, FailedLinkFrom: 0, FailedLinkTo: 0
,2020-03-03 13:22:26.380 Detail, Node007,   Expected callbackId was received
,2020-03-03 13:22:26.392 Detail, Node007,   Received: 0x01, 0x0c, 0x00, 0x04, 0x00, 0x07, 0x04, 0x71, 0x08, 0x01, 0xc0, 0xcf, 0x00, 0x83
,2020-03-03 13:22:26.392 Detail, 
,2020-03-03 13:22:26.392 Info, Node007, Response RTT 41 Average Response RTT 41
,2020-03-03 13:22:26.392 Info, Node007, Received supported alarm types
,2020-03-03 13:22:26.392 Info, Node007,     AlarmType: Access Control
,2020-03-03 13:22:26.392 Detail, Node007, Queuing (Send) AlarmCmd_Event_Supported_Get (Node=7): 0x01, 0x0a, 0x00, 0x13, 0x07, 0x03, 0x71, 0x01, 0x06, 0x25, 0x25, 0x94
,2020-03-03 13:22:26.392 Info, Node007,     AlarmType: Home Security
,2020-03-03 13:22:26.392 Detail, Node007, Queuing (Send) AlarmCmd_Event_Supported_Get (Node=7): 0x01, 0x0a, 0x00, 0x13, 0x07, 0x03, 0x71, 0x01, 0x07, 0x25, 0x26, 0x96
,2020-03-03 13:22:26.392 Detail, Node007,   Expected reply and command class was received
,2020-03-03 13:22:26.393 Detail, Node007,   Message transaction complete
,2020-03-03 13:22:26.393 Detail, 
,2020-03-03 13:22:26.393 Detail, Node007, Removing current message
,2020-03-03 13:22:26.393 Detail, 
,2020-03-03 13:22:26.393 Info, Node007, Sending (Send) message (Callback ID=0x25, Expected Reply=0x04) - AlarmCmd_Event_Supported_Get (Node=7): 0x01, 0x0a, 0x00, 0x13, 0x07, 0x03, 0x71, 0x01, 0x06, 0x25, 0x25, 0x94
,2020-03-03 13:22:26.393 Info, Node007, Encrypted Flag is 0
,2020-03-03 13:22:26.401 Detail, Node007,   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
,2020-03-03 13:22:26.401 Detail, Node007,   ZW_SEND_DATA delivered to Z-Wave stack
,2020-03-03 13:22:26.421 Detail, Node007,   Received: 0x01, 0x18, 0x00, 0x13, 0x25, 0x00, 0x00, 0x02, 0x00, 0xcf, 0x7f, 0x7f, 0x7f, 0x7f, 0x00, 0x00, 0x03, 0x00, 0x00, 0x00, 0x00, 0x03, 0x01, 0x00, 0x00, 0x1d
,2020-03-03 13:22:26.422 Detail, Node007,   ZW_SEND_DATA Request with callback ID 0x25 received (expected 0x25)
,2020-03-03 13:22:26.422 Info, Node007, Request RTT 28 Average Request RTT 28
,2020-03-03 13:22:26.422 Detail, Node007, Extended TxStatus: Time: 20, Hops: 0, Rssi:  -49 --- --- --- ---, AckChannel: 0, TxChannel: 0, RouteScheme: Last Working Route, Route: 0 0 0 0, RouteSpeed: 100K, RouteTries: 1, FailedLinkFrom: 0, FailedLinkTo: 0
,2020-03-03 13:22:26.422 Detail, Node007,   Expected callbackId was received
,2020-03-03 13:22:26.434 Detail, Node007,   Received: 0x01, 0x0f, 0x00, 0x04, 0x00, 0x07, 0x07, 0x71, 0x02, 0x06, 0x03, 0x00, 0x00, 0xc0, 0xcf, 0x00, 0x8d
,2020-03-03 13:22:26.434 Detail, 
,2020-03-03 13:22:26.434 Info, Node007, Response RTT 41 Average Response RTT 41
,2020-03-03 13:22:26.434 Info, Node007, Received supported alarm Event types for AlarmType Access Control (6)
,2020-03-03 13:22:26.434 Info, Node007,     Event Type 0: Clear 
,2020-03-03 13:22:26.435 Info, Node007,     Event Type 22: Door/Window Open 
,2020-03-03 13:22:26.435 Info, Node007,     Event Type 23: Door/Window Closed 
,2020-03-03 13:22:26.435 Detail, Node007,   Expected reply and command class was received
,2020-03-03 13:22:26.435 Detail, Node007,   Message transaction complete
,2020-03-03 13:22:26.435 Detail, 
,2020-03-03 13:22:26.435 Detail, Node007, Removing current message
,2020-03-03 13:22:26.435 Detail, Node007, Notification: ValueAdded CC: COMMAND_CLASS_NOTIFICATION Instance: 1 Index: 256
,2020-03-03 13:22:26.435 Detail, Node007, Notification: ValueAdded CC: COMMAND_CLASS_NOTIFICATION Instance: 1 Index: 6
,2020-03-03 13:22:26.435 Detail, 
,2020-03-03 13:22:26.435 Info, Node007, Sending (Send) message (Callback ID=0x26, Expected Reply=0x04) - AlarmCmd_Event_Supported_Get (Node=7): 0x01, 0x0a, 0x00, 0x13, 0x07, 0x03, 0x71, 0x01, 0x07, 0x25, 0x26, 0x96
,2020-03-03 13:22:26.435 Info, Node007, Encrypted Flag is 0
,  z2m:Zwave ValueAdded: 7-113-1-256 Previous Event Cleared +93ms
,  z2m:Zwave ValueAdded: 7-113-1-6 Access Control +1ms
,2020-03-03 13:22:26.444 Detail, Node007,   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
,2020-03-03 13:22:26.444 Detail, Node007,   ZW_SEND_DATA delivered to Z-Wave stack
,2020-03-03 13:22:26.464 Detail, Node007,   Received: 0x01, 0x18, 0x00, 0x13, 0x26, 0x00, 0x00, 0x02, 0x00, 0xcf, 0x7f, 0x7f, 0x7f, 0x7f, 0x00, 0x00, 0x03, 0x00, 0x00, 0x00, 0x00, 0x03, 0x01, 0x00, 0x00, 0x1e
,2020-03-03 13:22:26.464 Detail, Node007,   ZW_SEND_DATA Request with callback ID 0x26 received (expected 0x26)
,2020-03-03 13:22:26.464 Info, Node007, Request RTT 28 Average Request RTT 28
,2020-03-03 13:22:26.464 Detail, Node007, Extended TxStatus: Time: 20, Hops: 0, Rssi:  -49 --- --- --- ---, AckChannel: 0, TxChannel: 0, RouteScheme: Last Working Route, Route: 0 0 0 0, RouteSpeed: 100K, RouteTries: 1, FailedLinkFrom: 0, FailedLinkTo: 0
,2020-03-03 13:22:26.464 Detail, Node007,   Expected callbackId was received
,2020-03-03 13:22:26.476 Detail, Node007,   Received: 0x01, 0x0d, 0x00, 0x04, 0x00, 0x07, 0x05, 0x71, 0x02, 0x07, 0x01, 0x08, 0xcf, 0x00, 0x46
,2020-03-03 13:22:26.476 Detail, 
,2020-03-03 13:22:26.477 Info, Node007, Response RTT 41 Average Response RTT 41
,2020-03-03 13:22:26.477 Info, Node007, Received supported alarm Event types for AlarmType Home Security (7)
,2020-03-03 13:22:26.477 Info, Node007,     Event Type 0: Clear 
,2020-03-03 13:22:26.477 Info, Node007,     Event Type 3: Tampering -  Cover Removed 
,2020-03-03 13:22:26.477 Detail, Node007,   Expected reply and command class was received
,2020-03-03 13:22:26.477 Detail, Node007,   Message transaction complete
,2020-03-03 13:22:26.477 Detail, 
,2020-03-03 13:22:26.477 Detail, Node007, Removing current message
,2020-03-03 13:22:26.477 Detail, Node007, Notification: ValueAdded CC: COMMAND_CLASS_NOTIFICATION Instance: 1 Index: 7
,2020-03-03 13:22:26.477 Detail, 
,2020-03-03 13:22:26.477 Info, Node007, Sending (Query) message (Callback ID=0x20, Expected Reply=0x04) - ManufacturerSpecificCmd_DeviceGet_DeviceIDType_FactoryDefault (Node=7): 0x01, 0x0a, 0x00, 0x13, 0x07, 0x03, 0x72, 0x06, 0x00, 0x25, 0x20, 0x93
,2020-03-03 13:22:26.477 Info, Node007, Encrypted Flag is 0
,  z2m:Zwave ValueAdded: 7-113-1-7 Home Security +41ms
,2020-03-03 13:22:26.486 Detail, Node007,   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
,2020-03-03 13:22:26.486 Detail, Node007,   ZW_SEND_DATA delivered to Z-Wave stack
,2020-03-03 13:22:26.506 Detail, Node007,   Received: 0x01, 0x18, 0x00, 0x13, 0x20, 0x00, 0x00, 0x02, 0x00, 0xcf, 0x7f, 0x7f, 0x7f, 0x7f, 0x00, 0x00, 0x03, 0x00, 0x00, 0x00, 0x00, 0x03, 0x01, 0x00, 0x00, 0x18
,2020-03-03 13:22:26.507 Detail, Node007,   ZW_SEND_DATA Request with callback ID 0x20 received (expected 0x20)
,2020-03-03 13:22:26.507 Info, Node007, Request RTT 29 Average Request RTT 28
,2020-03-03 13:22:26.507 Detail, Node007, Extended TxStatus: Time: 20, Hops: 0, Rssi:  -49 --- --- --- ---, AckChannel: 0, TxChannel: 0, RouteScheme: Last Working Route, Route: 0 0 0 0, RouteSpeed: 100K, RouteTries: 1, FailedLinkFrom: 0, FailedLinkTo: 0
,2020-03-03 13:22:26.507 Detail, Node007,   Expected callbackId was received
,2020-03-03 13:22:26.520 Detail, Node007,   Received: 0x01, 0x14, 0x00, 0x04, 0x00, 0x07, 0x0c, 0x72, 0x07, 0x02, 0x28, 0x99, 0x43, 0xdb, 0x09, 0x58, 0xf7, 0x09, 0xc3, 0xcf, 0x00, 0x19
,2020-03-03 13:22:26.520 Detail, 
,2020-03-03 13:22:26.520 Info, Node007, Response RTT 42 Average Response RTT 41
,2020-03-03 13:22:26.520 Detail, Node007,   Expected reply and command class was received
,2020-03-03 13:22:26.520 Detail, Node007,   Message transaction complete
,2020-03-03 13:22:26.520 Detail, 
,2020-03-03 13:22:26.520 Detail, Node007, Removing current message
,2020-03-03 13:22:26.521 Detail, 
,2020-03-03 13:22:26.521 Info, Node007, Sending (Query) message (Callback ID=0x21, Expected Reply=0x04) - ManufacturerSpecificCmd_DeviceGet_DeviceIDType_SerialNumber (Node=7): 0x01, 0x0a, 0x00, 0x13, 0x07, 0x03, 0x72, 0x06, 0x01, 0x25, 0x21, 0x93
,2020-03-03 13:22:26.521 Info, Node007, Encrypted Flag is 0
,2020-03-03 13:22:26.530 Detail, Node007,   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
,2020-03-03 13:22:26.530 Detail, Node007,   ZW_SEND_DATA delivered to Z-Wave stack
,2020-03-03 13:22:26.550 Detail, Node007,   Received: 0x01, 0x18, 0x00, 0x13, 0x21, 0x00, 0x00, 0x02, 0x00, 0xcf, 0x7f, 0x7f, 0x7f, 0x7f, 0x00, 0x00, 0x03, 0x00, 0x00, 0x00, 0x00, 0x03, 0x01, 0x00, 0x00, 0x19
,2020-03-03 13:22:26.550 Detail, Node007,   ZW_SEND_DATA Request with callback ID 0x21 received (expected 0x21)
,2020-03-03 13:22:26.550 Info, Node007, Request RTT 29 Average Request RTT 28
,2020-03-03 13:22:26.550 Detail, Node007, Extended TxStatus: Time: 20, Hops: 0, Rssi:  -49 --- --- --- ---, AckChannel: 0, TxChannel: 0, RouteScheme: Last Working Route, Route: 0 0 0 0, RouteSpeed: 100K, RouteTries: 1, FailedLinkFrom: 0, FailedLinkTo: 0
,2020-03-03 13:22:26.550 Detail, Node007,   Expected callbackId was received
,GET / 304 1.132 ms - -
,  z2m:App User disconnected auUg6-MiAafcqAT3AAAB +10s
,GET /static/css/app.6071a1385bbbf2e6bba673b992155bbf.css 304 3.153 ms - -
,GET /static/js/manifest.2ae2e69a05c33dfc65f8.js 304 2.686 ms - -
,GET /static/js/vendor.232393204655456e084d.js 304 2.535 ms - -
,GET /static/js/app.e8d7c6e9965f090643b4.js 304 0.831 ms - -
,  z2m:App New connection JHdR4Ff4_GdA_-x8AAAC +205ms
,GET /static/logo.png 304 0.875 ms - -
,GET /static/favicons/favicon-32x32.png 200 1.116 ms - 1831
,2020-03-03 13:22:36.522 Error, Node007, ERROR: Dropping command, expected response not received after 1 attempt(s). Command: "ManufacturerSpecificCmd_DeviceGet_DeviceIDType_SerialNumber (Node=7): 0x01, 0x0a, 0x00, 0x13, 0x07, 0x03, 0x72, 0x06, 0x01, 0x25, 0x21, 0x93"
,2020-03-03 13:22:36.522 Detail, Node007, Removing current message
,2020-03-03 13:22:36.522 Detail, Node007, Notification: Notification - TimeOut
,2020-03-03 13:22:36.522 Detail, 
,2020-03-03 13:22:36.522 Info, Node007, Sending (Query) message (Callback ID=0x22, Expected Reply=0x04) - WakeUpCmd_IntervalCapabilityGet (Node=7): 0x01, 0x09, 0x00, 0x13, 0x07, 0x02, 0x84, 0x09, 0x25, 0x22, 0x6a
,2020-03-03 13:22:36.522 Info, Node007, Encrypted Flag is 0
,  z2m:Zwave Notification from node 7: Notification - TimeOut (1) +10s
,2020-03-03 13:22:36.529 Detail, Node007,   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
,2020-03-03 13:22:36.529 Detail, Node007,   ZW_SEND_DATA delivered to Z-Wave stack
,2020-03-03 13:22:36.550 Detail, Node007,   Received: 0x01, 0x18, 0x00, 0x13, 0x22, 0x00, 0x00, 0x02, 0x00, 0xdb, 0x7f, 0x7f, 0x7f, 0x7f, 0x00, 0x00, 0x03, 0x00, 0x00, 0x00, 0x00, 0x03, 0x01, 0x00, 0x00, 0x0e
,2020-03-03 13:22:36.550 Detail, Node007,   ZW_SEND_DATA Request with callback ID 0x22 received (expected 0x22)
,2020-03-03 13:22:36.550 Info, Node007, Request RTT 27 Average Request RTT 27
,2020-03-03 13:22:36.550 Detail, Node007, Extended TxStatus: Time: 20, Hops: 0, Rssi:  -37 --- --- --- ---, AckChannel: 0, TxChannel: 0, RouteScheme: Last Working Route, Route: 0 0 0 0, RouteSpeed: 100K, RouteTries: 1, FailedLinkFrom: 0, FailedLinkTo: 0
,2020-03-03 13:22:36.550 Detail, Node007,   Expected callbackId was received
,2020-03-03 13:22:36.563 Detail, Node007,   Received: 0x01, 0x16, 0x00, 0x04, 0x00, 0x07, 0x0e, 0x84, 0x0a, 0x00, 0x07, 0x08, 0x01, 0x51, 0x80, 0x01, 0x51, 0x80, 0x00, 0x00, 0xb4, 0xdb, 0x00, 0x0a
,2020-03-03 13:22:36.563 Detail, 
,2020-03-03 13:22:36.563 Info, Node007, Response RTT 41 Average Response RTT 41
,2020-03-03 13:22:36.563 Info, Node007, Received Wakeup Interval Capability report from node 7: Min Interval=1800, Max Interval=86400, Default Interval=86400, Interval Step=180
,2020-03-03 13:22:36.564 Detail, Node007, Initial read of value
,2020-03-03 13:22:36.564 Detail, Node007, Initial read of value
,2020-03-03 13:22:36.564 Detail, Node007, Initial read of value
,2020-03-03 13:22:36.564 Detail, Node007, Initial read of value
,2020-03-03 13:22:36.564 Detail, Node007,   Expected reply and command class was received
,2020-03-03 13:22:36.564 Detail, Node007,   Message transaction complete
,2020-03-03 13:22:36.564 Detail, 
,2020-03-03 13:22:36.564 Detail, Node007, Removing current message
,2020-03-03 13:22:36.564 Detail, Node007, Notification: ValueChanged CC: COMMAND_CLASS_WAKE_UP Instance: 1 Index: 1
,2020-03-03 13:22:36.564 Detail, Node007, Notification: ValueChanged CC: COMMAND_CLASS_WAKE_UP Instance: 1 Index: 2
,2020-03-03 13:22:36.565 Detail, Node007, Notification: ValueChanged CC: COMMAND_CLASS_WAKE_UP Instance: 1 Index: 3
,2020-03-03 13:22:36.565 Detail, Node007, Notification: ValueChanged CC: COMMAND_CLASS_WAKE_UP Instance: 1 Index: 4
,2020-03-03 13:22:36.565 Detail, 
,2020-03-03 13:22:36.565 Info, Node007, Sending (Query) message (Callback ID=0x23, Expected Reply=0x04) - AssociationCmd_GroupingsGet (Node=7): 0x01, 0x09, 0x00, 0x13, 0x07, 0x02, 0x85, 0x05, 0x25, 0x23, 0x66
,2020-03-03 13:22:36.565 Info, Node007, Encrypted Flag is 0
,2020-03-03 13:22:36.573 Detail, Node007,   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
,2020-03-03 13:22:36.573 Detail, Node007,   ZW_SEND_DATA delivered to Z-Wave stack
,2020-03-03 13:22:36.593 Detail, Node007,   Received: 0x01, 0x18, 0x00, 0x13, 0x23, 0x00, 0x00, 0x02, 0x00, 0xdb, 0x7f, 0x7f, 0x7f, 0x7f, 0x00, 0x00, 0x03, 0x00, 0x00, 0x00, 0x00, 0x03, 0x01, 0x00, 0x00, 0x0f
,2020-03-03 13:22:36.593 Detail, Node007,   ZW_SEND_DATA Request with callback ID 0x23 received (expected 0x23)
,2020-03-03 13:22:36.593 Info, Node007, Request RTT 28 Average Request RTT 27
,2020-03-03 13:22:36.593 Detail, Node007, Extended TxStatus: Time: 20, Hops: 0, Rssi:  -37 --- --- --- ---, AckChannel: 0, TxChannel: 0, RouteScheme: Last Working Route, Route: 0 0 0 0, RouteSpeed: 100K, RouteTries: 1, FailedLinkFrom: 0, FailedLinkTo: 0
,2020-03-03 13:22:36.593 Detail, Node007,   Expected callbackId was received
,2020-03-03 13:22:36.605 Detail, Node007,   Received: 0x01, 0x0b, 0x00, 0x04, 0x00, 0x07, 0x03, 0x85, 0x06, 0x02, 0xdb, 0x00, 0xae
,2020-03-03 13:22:36.605 Detail, 
,2020-03-03 13:22:36.605 Info, Node007, Response RTT 40 Average Response RTT 40
,2020-03-03 13:22:36.605 Info, Node007, Received Association Groupings report from node 7. Number of groups is 2
,2020-03-03 13:22:36.605 Detail, Node007,   Expected reply and command class was received
,2020-03-03 13:22:36.605 Detail, Node007,   Message transaction complete
,2020-03-03 13:22:36.605 Detail, 
,2020-03-03 13:22:36.605 Detail, Node007, Removing current message
,2020-03-03 13:22:36.605 Detail, 
,2020-03-03 13:22:36.605 Info, Node007, Sending (Query) message (Callback ID=0x24, Expected Reply=0x04) - VersionCmd_Get (Node=7): 0x01, 0x09, 0x00, 0x13, 0x07, 0x02, 0x86, 0x11, 0x25, 0x24, 0x76
,2020-03-03 13:22:36.605 Info, Node007, Encrypted Flag is 0
,2020-03-03 13:22:36.615 Detail, Node007,   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
,2020-03-03 13:22:36.615 Detail, Node007,   ZW_SEND_DATA delivered to Z-Wave stack
,2020-03-03 13:22:36.635 Detail, Node007,   Received: 0x01, 0x18, 0x00, 0x13, 0x24, 0x00, 0x00, 0x02, 0x00, 0xdb, 0x7f, 0x7f, 0x7f, 0x7f, 0x00, 0x00, 0x03, 0x00, 0x00, 0x00, 0x00, 0x03, 0x01, 0x00, 0x00, 0x08
,2020-03-03 13:22:36.635 Detail, Node007,   ZW_SEND_DATA Request with callback ID 0x24 received (expected 0x24)
,2020-03-03 13:22:36.635 Info, Node007, Request RTT 29 Average Request RTT 28
,2020-03-03 13:22:36.635 Detail, Node007, Extended TxStatus: Time: 20, Hops: 0, Rssi:  -37 --- --- --- ---, AckChannel: 0, TxChannel: 0, RouteScheme: Last Working Route, Route: 0 0 0 0, RouteSpeed: 100K, RouteTries: 1, FailedLinkFrom: 0, FailedLinkTo: 0
,2020-03-03 13:22:36.635 Detail, Node007,   Expected callbackId was received
,2020-03-03 13:22:36.648 Detail, Node007,   Received: 0x01, 0x11, 0x00, 0x04, 0x00, 0x07, 0x09, 0x86, 0x12, 0x06, 0x04, 0x26, 0x06, 0x26, 0xff, 0x00, 0xdb, 0x00, 0x50
,2020-03-03 13:22:36.648 Detail, 
,2020-03-03 13:22:36.648 Info, Node007, Response RTT 42 Average Response RTT 41
,2020-03-03 13:22:36.648 Info, Node007, Received Version report from node 7: Library=6, Protocol=4.38, Application=6.38
,2020-03-03 13:22:36.648 Detail, Node007, Initial read of value
,2020-03-03 13:22:36.648 Detail, Node007, Initial read of value
,2020-03-03 13:22:36.648 Detail, Node007, Initial read of value
,2020-03-03 13:22:36.648 Detail, Node007,   Expected reply and command class was received
,2020-03-03 13:22:36.648 Detail, Node007,   Message transaction complete
,2020-03-03 13:22:36.648 Detail, 
,2020-03-03 13:22:36.648 Detail, Node007, Removing current message
,2020-03-03 13:22:36.648 Detail, Node007, Notification: ValueChanged CC: COMMAND_CLASS_VERSION Instance: 1 Index: 0
,2020-03-03 13:22:36.648 Detail, Node007, Notification: ValueChanged CC: COMMAND_CLASS_VERSION Instance: 1 Index: 1
,2020-03-03 13:22:36.648 Detail, Node007, Notification: ValueChanged CC: COMMAND_CLASS_VERSION Instance: 1 Index: 2
,2020-03-03 13:22:36.648 Detail, Node007, Query Stage Complete (Static)
,2020-03-03 13:22:36.648 Detail, Node007, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Associations live=1
,2020-03-03 13:22:36.648 Detail, Node007, QueryStage_Associations
,2020-03-03 13:22:36.648 Info, Node007, Number of association groups reported for node 7 is 2.
,2020-03-03 13:22:36.648 Info, Node007, Get Associations for group 1 of node 7
,2020-03-03 13:22:36.648 Detail, Node007, Queuing (Send) AssociationCmd_Get (Node=7): 0x01, 0x0a, 0x00, 0x13, 0x07, 0x03, 0x85, 0x02, 0x01, 0x25, 0x27, 0x66
,2020-03-03 13:22:36.648 Detail, Node007, Queuing (Query) Query Stage Complete (Associations)
,2020-03-03 13:22:36.648 Detail, 
,2020-03-03 13:22:36.648 Info, Node007, Sending (Send) message (Callback ID=0x27, Expected Reply=0x04) - AssociationCmd_Get (Node=7): 0x01, 0x0a, 0x00, 0x13, 0x07, 0x03, 0x85, 0x02, 0x01, 0x25, 0x27, 0x66
,2020-03-03 13:22:36.648 Info, Node007, Encrypted Flag is 0
,2020-03-03 13:22:36.658 Detail, Node007,   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
,2020-03-03 13:22:36.658 Detail, Node007,   ZW_SEND_DATA delivered to Z-Wave stack
,2020-03-03 13:22:36.678 Detail, Node007,   Received: 0x01, 0x18, 0x00, 0x13, 0x27, 0x00, 0x00, 0x02, 0x00, 0xdb, 0x7f, 0x7f, 0x7f, 0x7f, 0x00, 0x00, 0x03, 0x00, 0x00, 0x00, 0x00, 0x03, 0x01, 0x00, 0x00, 0x0b
,2020-03-03 13:22:36.678 Detail, Node007,   ZW_SEND_DATA Request with callback ID 0x27 received (expected 0x27)
,2020-03-03 13:22:36.678 Info, Node007, Request RTT 29 Average Request RTT 28
,2020-03-03 13:22:36.679 Detail, Node007, Extended TxStatus: Time: 20, Hops: 0, Rssi:  -37 --- --- --- ---, AckChannel: 0, TxChannel: 0, RouteScheme: Last Working Route, Route: 0 0 0 0, RouteSpeed: 100K, RouteTries: 1, FailedLinkFrom: 0, FailedLinkTo: 0
,2020-03-03 13:22:36.679 Detail, Node007,   Expected callbackId was received
,2020-03-03 13:22:36.702 Detail, Node007,   Received: 0x01, 0x0d, 0x00, 0x04, 0x00, 0x07, 0x05, 0x85, 0x03, 0x01, 0x01, 0x00, 0xdb, 0x00, 0xa9
,2020-03-03 13:22:36.703 Detail, 
,2020-03-03 13:22:36.703 Info, Node007, Response RTT 54 Average Response RTT 47
,2020-03-03 13:22:36.703 Info, Node007, Received Association report from node 7, group 1, containing 0 associations
,2020-03-03 13:22:36.703 Info, Node007, Get Associations for group 2 of node 7
,2020-03-03 13:22:36.703 Detail, Node007, Queuing (Send) AssociationCmd_Get (Node=7): 0x01, 0x0a, 0x00, 0x13, 0x07, 0x03, 0x85, 0x02, 0x02, 0x25, 0x28, 0x6a
,2020-03-03 13:22:36.703 Detail, Node007,   Expected reply and command class was received
,2020-03-03 13:22:36.703 Detail, Node007,   Message transaction complete
,2020-03-03 13:22:36.703 Detail, 
,2020-03-03 13:22:36.703 Detail, Node007, Removing current message
,2020-03-03 13:22:36.703 Detail, Node007, Notification: Group
,2020-03-03 13:22:36.703 Detail, 
,2020-03-03 13:22:36.703 Info, Node007, Sending (Send) message (Callback ID=0x28, Expected Reply=0x04) - AssociationCmd_Get (Node=7): 0x01, 0x0a, 0x00, 0x13, 0x07, 0x03, 0x85, 0x02, 0x02, 0x25, 0x28, 0x6a
,2020-03-03 13:22:36.704 Info, Node007, Encrypted Flag is 0
,2020-03-03 13:22:36.712 Detail, Node007,   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
,2020-03-03 13:22:36.712 Detail, Node007,   ZW_SEND_DATA delivered to Z-Wave stack
,2020-03-03 13:22:36.732 Detail, Node007,   Received: 0x01, 0x18, 0x00, 0x13, 0x28, 0x00, 0x00, 0x02, 0x00, 0xdb, 0x7f, 0x7f, 0x7f, 0x7f, 0x00, 0x00, 0x03, 0x00, 0x00, 0x00, 0x00, 0x03, 0x01, 0x00, 0x00, 0x04
,2020-03-03 13:22:36.733 Detail, Node007,   ZW_SEND_DATA Request with callback ID 0x28 received (expected 0x28)
,2020-03-03 13:22:36.733 Info, Node007, Request RTT 29 Average Request RTT 28
,2020-03-03 13:22:36.733 Detail, Node007, Extended TxStatus: Time: 20, Hops: 0, Rssi:  -37 --- --- --- ---, AckChannel: 0, TxChannel: 0, RouteScheme: Last Working Route, Route: 0 0 0 0, RouteSpeed: 100K, RouteTries: 1, FailedLinkFrom: 0, FailedLinkTo: 0
,2020-03-03 13:22:36.733 Detail, Node007,   Expected callbackId was received
,2020-03-03 13:22:36.757 Detail, Node007,   Received: 0x01, 0x0d, 0x00, 0x04, 0x00, 0x07, 0x05, 0x85, 0x03, 0x02, 0x02, 0x00, 0xdb, 0x00, 0xa9
,2020-03-03 13:22:36.757 Detail, 
,2020-03-03 13:22:36.757 Info, Node007, Response RTT 53 Average Response RTT 50
,2020-03-03 13:22:36.757 Info, Node007, Received Association report from node 7, group 2, containing 0 associations
,2020-03-03 13:22:36.757 Info, Node007, Querying associations for node 7 is complete.
,2020-03-03 13:22:36.757 Info, Node007, Adding the controller to group 1 (Lifeline) of node 7
,2020-03-03 13:22:36.757 Info, Node007, Association::Set - Adding node 1 to group 1 of node 7
,2020-03-03 13:22:36.757 Detail, Node007, Queuing (Send) AssociationCmd_Set (Node=7): 0x01, 0x0b, 0x00, 0x13, 0x07, 0x04, 0x85, 0x01, 0x01, 0x01, 0x25, 0x29, 0x6c
,2020-03-03 13:22:36.757 Info, Node007, Get Associations for group 1 of node 7
,2020-03-03 13:22:36.758 Detail, Node007, Queuing (Send) AssociationCmd_Get (Node=7): 0x01, 0x0a, 0x00, 0x13, 0x07, 0x03, 0x85, 0x02, 0x01, 0x25, 0x2a, 0x6b
,2020-03-03 13:22:36.758 Detail, Node007,   Expected reply and command class was received
,2020-03-03 13:22:36.758 Detail, Node007,   Message transaction complete
,2020-03-03 13:22:36.758 Detail, 
,2020-03-03 13:22:36.758 Detail, Node007, Removing current message
,2020-03-03 13:22:36.758 Detail, Node007, Notification: Group
,2020-03-03 13:22:36.758 Detail, 
,2020-03-03 13:22:36.758 Info, Node007, Sending (Send) message (Callback ID=0x29, Expected Reply=0x13) - AssociationCmd_Set (Node=7): 0x01, 0x0b, 0x00, 0x13, 0x07, 0x04, 0x85, 0x01, 0x01, 0x01, 0x25, 0x29, 0x6c
,2020-03-03 13:22:36.758 Info, Node007, Encrypted Flag is 0
,2020-03-03 13:22:36.766 Detail, Node007,   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
,2020-03-03 13:22:36.766 Detail, Node007,   ZW_SEND_DATA delivered to Z-Wave stack
,2020-03-03 13:22:36.786 Detail, Node007,   Received: 0x01, 0x18, 0x00, 0x13, 0x29, 0x00, 0x00, 0x02, 0x00, 0xdb, 0x7f, 0x7f, 0x7f, 0x7f, 0x00, 0x00, 0x03, 0x00, 0x00, 0x00, 0x00, 0x03, 0x01, 0x00, 0x00, 0x05
,2020-03-03 13:22:36.786 Detail, Node007,   ZW_SEND_DATA Request with callback ID 0x29 received (expected 0x29)
,2020-03-03 13:22:36.787 Info, Node007, Request RTT 27 Average Request RTT 27
,2020-03-03 13:22:36.787 Detail, Node007, Extended TxStatus: Time: 20, Hops: 0, Rssi:  -37 --- --- --- ---, AckChannel: 0, TxChannel: 0, RouteScheme: Last Working Route, Route: 0 0 0 0, RouteSpeed: 100K, RouteTries: 1, FailedLinkFrom: 0, FailedLinkTo: 0
,2020-03-03 13:22:36.787 Detail, Node007,   Expected callbackId was received
,2020-03-03 13:22:36.787 Detail, Node007,   Expected reply was received
,2020-03-03 13:22:36.787 Detail, Node007,   Message transaction complete
,2020-03-03 13:22:36.787 Detail, 
,2020-03-03 13:22:36.787 Detail, Node007, Removing current message
,2020-03-03 13:22:36.787 Detail, 
,2020-03-03 13:22:36.787 Info, Node007, Sending (Send) message (Callback ID=0x2a, Expected Reply=0x04) - AssociationCmd_Get (Node=7): 0x01, 0x0a, 0x00, 0x13, 0x07, 0x03, 0x85, 0x02, 0x01, 0x25, 0x2a, 0x6b
,2020-03-03 13:22:36.787 Info, Node007, Encrypted Flag is 0
,2020-03-03 13:22:36.795 Detail, Node007,   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
,2020-03-03 13:22:36.795 Detail, Node007,   ZW_SEND_DATA delivered to Z-Wave stack
,2020-03-03 13:22:36.819 Detail, Node007,   Received: 0x01, 0x18, 0x00, 0x13, 0x2a, 0x00, 0x00, 0x02, 0x00, 0xdb, 0x7f, 0x7f, 0x7f, 0x7f, 0x00, 0x00, 0x03, 0x00, 0x00, 0x00, 0x00, 0x03, 0x01, 0x00, 0x00, 0x06
,2020-03-03 13:22:36.820 Detail, Node007,   ZW_SEND_DATA Request with callback ID 0x2a received (expected 0x2a)
,2020-03-03 13:22:36.820 Info, Node007, Request RTT 32 Average Request RTT 29
,2020-03-03 13:22:36.820 Detail, Node007, Extended TxStatus: Time: 20, Hops: 0, Rssi:  -37 --- --- --- ---, AckChannel: 0, TxChannel: 0, RouteScheme: Last Working Route, Route: 0 0 0 0, RouteSpeed: 100K, RouteTries: 1, FailedLinkFrom: 0, FailedLinkTo: 0
,2020-03-03 13:22:36.820 Detail, Node007,   Expected callbackId was received
,2020-03-03 13:22:36.847 Detail, Node007,   Received: 0x01, 0x0e, 0x00, 0x04, 0x00, 0x07, 0x06, 0x85, 0x03, 0x01, 0x01, 0x00, 0x01, 0xdb, 0x00, 0xa8
,2020-03-03 13:22:36.847 Detail, 
,2020-03-03 13:22:36.847 Info, Node007, Response RTT 59 Average Response RTT 54
,2020-03-03 13:22:36.847 Info, Node007, Received Association report from node 7, group 1, containing 1 associations
,2020-03-03 13:22:36.847 Info, Node007,   The group contains:
,2020-03-03 13:22:36.847 Info, Node007,     Node 1
,2020-03-03 13:22:36.847 Detail, Node007,   Expected reply and command class was received
,2020-03-03 13:22:36.847 Detail, Node007,   Message transaction complete
,2020-03-03 13:22:36.847 Detail, 
,2020-03-03 13:22:36.847 Detail, Node007, Removing current message
,2020-03-03 13:22:36.847 Detail, Node007, Notification: Group
,2020-03-03 13:22:36.847 Detail, Node007, Query Stage Complete (Associations)
,2020-03-03 13:22:36.847 Detail, Node007, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Neighbors live=1
,2020-03-03 13:22:36.848 Detail, Node007, QueryStage_Neighbors
,2020-03-03 13:22:36.848 Detail, Requesting routing info (neighbor list) for Node 7
,2020-03-03 13:22:36.848 Detail, Node007, Queuing (Command) Get Routing Info (Node=7): 0x01, 0x07, 0x00, 0x80, 0x07, 0x00, 0x00, 0x03, 0x7c
,2020-03-03 13:22:36.848 Detail, Node007, Queuing (Query) Query Stage Complete (Neighbors)
,2020-03-03 13:22:36.848 Detail, 
,2020-03-03 13:22:36.848 Info, Node007, Sending (Command) message (Callback ID=0x00, Expected Reply=0x80) - Get Routing Info (Node=7): 0x01, 0x07, 0x00, 0x80, 0x07, 0x00, 0x00, 0x03, 0x7c
,2020-03-03 13:22:36.848 Info, Node007, Encrypted Flag is 0
,2020-03-03 13:22:36.853 Detail, Node007,   Received: 0x01, 0x20, 0x01, 0x80, 0x01, 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, 0x5f
,2020-03-03 13:22:36.853 Detail, 
,2020-03-03 13:22:36.854 Info, Node007, Received reply to FUNC_ID_ZW_GET_ROUTING_INFO
,2020-03-03 13:22:36.854 Info, Node007,     Neighbors of this node are:
,2020-03-03 13:22:36.854 Info, Node007,     Node 1
,2020-03-03 13:22:36.854 Detail, Node007,   Expected reply was received
,2020-03-03 13:22:36.854 Detail, Node007,   Message transaction complete
,2020-03-03 13:22:36.854 Detail, 
,2020-03-03 13:22:36.854 Detail, Node007, Removing current message
,2020-03-03 13:22:36.854 Detail, Node007, Query Stage Complete (Neighbors)
,2020-03-03 13:22:36.854 Detail, Node007, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Session live=1
,2020-03-03 13:22:36.854 Detail, Node007, QueryStage_Session
,2020-03-03 13:22:36.854 Detail, Node007, Queuing (Query) PowerlevelCmd_Get (Node=7): 0x01, 0x09, 0x00, 0x13, 0x07, 0x02, 0x73, 0x02, 0x25, 0x2b, 0x9f
,2020-03-03 13:22:36.854 Detail, Node007, Queuing (Query) Query Stage Complete (Session)
,2020-03-03 13:22:36.854 Detail, 
,2020-03-03 13:22:36.854 Info, Node007, Sending (Query) message (Callback ID=0x2b, Expected Reply=0x04) - PowerlevelCmd_Get (Node=7): 0x01, 0x09, 0x00, 0x13, 0x07, 0x02, 0x73, 0x02, 0x25, 0x2b, 0x9f
,2020-03-03 13:22:36.855 Info, Node007, Encrypted Flag is 0
,2020-03-03 13:22:36.862 Detail, Node007,   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
,2020-03-03 13:22:36.862 Detail, Node007,   ZW_SEND_DATA delivered to Z-Wave stack
,2020-03-03 13:22:36.882 Detail, Node007,   Received: 0x01, 0x18, 0x00, 0x13, 0x2b, 0x00, 0x00, 0x02, 0x00, 0xdb, 0x7f, 0x7f, 0x7f, 0x7f, 0x00, 0x00, 0x03, 0x00, 0x00, 0x00, 0x00, 0x03, 0x01, 0x00, 0x00, 0x07
,2020-03-03 13:22:36.882 Detail, Node007,   ZW_SEND_DATA Request with callback ID 0x2b received (expected 0x2b)
,2020-03-03 13:22:36.882 Info, Node007, Request RTT 27 Average Request RTT 28
,2020-03-03 13:22:36.882 Detail, Node007, Extended TxStatus: Time: 20, Hops: 0, Rssi:  -37 --- --- --- ---, AckChannel: 0, TxChannel: 0, RouteScheme: Last Working Route, Route: 0 0 0 0, RouteSpeed: 100K, RouteTries: 1, FailedLinkFrom: 0, FailedLinkTo: 0
,2020-03-03 13:22:36.882 Detail, Node007,   Expected callbackId was received
,2020-03-03 13:22:36.894 Detail, Node007,   Received: 0x01, 0x0c, 0x00, 0x04, 0x00, 0x07, 0x04, 0x73, 0x03, 0x00, 0x00, 0xdb, 0x00, 0x5f
,2020-03-03 13:22:36.894 Detail, 
,2020-03-03 13:22:36.895 Info, Node007, Response RTT 39 Average Response RTT 46
,2020-03-03 13:22:36.895 Info, Node007, Received a PowerLevel report: PowerLevel=Normal, Timeout=0
,2020-03-03 13:22:36.895 Detail, Node007, Initial read of value
,2020-03-03 13:22:36.895 Detail, Node007, Initial read of value
,2020-03-03 13:22:36.895 Detail, Node007,   Expected reply and command class was received
,2020-03-03 13:22:36.895 Detail, Node007,   Message transaction complete
,2020-03-03 13:22:36.895 Detail, 
,2020-03-03 13:22:36.895 Detail, Node007, Removing current message
,2020-03-03 13:22:36.895 Detail, Node007, Notification: ValueChanged CC: COMMAND_CLASS_POWERLEVEL Instance: 1 Index: 0
,2020-03-03 13:22:36.895 Detail, Node007, Notification: ValueChanged CC: COMMAND_CLASS_POWERLEVEL Instance: 1 Index: 1
,2020-03-03 13:22:36.895 Detail, Node007, Query Stage Complete (Session)
,2020-03-03 13:22:36.895 Detail, Node007, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Dynamic live=1
,2020-03-03 13:22:36.895 Detail, Node007, QueryStage_Dynamic
,2020-03-03 13:22:36.896 Detail, Node007, Queuing (Send) BasicCmd_Get (Node=7): 0x01, 0x09, 0x00, 0x13, 0x07, 0x02, 0x20, 0x02, 0x25, 0x2c, 0xcb
,2020-03-03 13:22:36.896 Detail, Node007, Queuing (Send) SensorBinaryCmd_Get (Node=7): 0x01, 0x09, 0x00, 0x13, 0x07, 0x02, 0x30, 0x02, 0x25, 0x2d, 0xda
,2020-03-03 13:22:36.896 Detail, Node007, Queuing (Send) AlarmCmd_Get (Node=7): 0x01, 0x0c, 0x00, 0x13, 0x07, 0x05, 0x71, 0x04, 0x00, 0xff, 0x00, 0x25, 0x2e, 0x63
,2020-03-03 13:22:36.896 Detail, Node007, Queuing (Send) BatteryCmd_Get (Node=7): 0x01, 0x09, 0x00, 0x13, 0x07, 0x02, 0x80, 0x02, 0x25, 0x2f, 0x68
,2020-03-03 13:22:36.896 Detail, Node007, Queuing (Query) Query Stage Complete (Dynamic)
,2020-03-03 13:22:36.896 Detail, 
,2020-03-03 13:22:36.896 Info, Node007, Sending (Send) message (Callback ID=0x2c, Expected Reply=0x04) - BasicCmd_Get (Node=7): 0x01, 0x09, 0x00, 0x13, 0x07, 0x02, 0x20, 0x02, 0x25, 0x2c, 0xcb
,2020-03-03 13:22:36.896 Info, Node007, Encrypted Flag is 0
,2020-03-03 13:22:36.904 Detail, Node007,   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
,2020-03-03 13:22:36.904 Detail, Node007,   ZW_SEND_DATA delivered to Z-Wave stack
,2020-03-03 13:22:36.924 Detail, Node007,   Received: 0x01, 0x18, 0x00, 0x13, 0x2c, 0x00, 0x00, 0x02, 0x00, 0xdb, 0x7f, 0x7f, 0x7f, 0x7f, 0x00, 0x00, 0x03, 0x00, 0x00, 0x00, 0x00, 0x03, 0x01, 0x00, 0x00, 0x00
,2020-03-03 13:22:36.924 Detail, Node007,   ZW_SEND_DATA Request with callback ID 0x2c received (expected 0x2c)
,2020-03-03 13:22:36.924 Info, Node007, Request RTT 27 Average Request RTT 27
,2020-03-03 13:22:36.924 Detail, Node007, Extended TxStatus: Time: 20, Hops: 0, Rssi:  -37 --- --- --- ---, AckChannel: 0, TxChannel: 0, RouteScheme: Last Working Route, Route: 0 0 0 0, RouteSpeed: 100K, RouteTries: 1, FailedLinkFrom: 0, FailedLinkTo: 0
,2020-03-03 13:22:36.924 Detail, Node007,   Expected callbackId was received
,2020-03-03 13:22:36.936 Detail, Node007,   Received: 0x01, 0x0b, 0x00, 0x04, 0x00, 0x07, 0x03, 0x20, 0x03, 0xff, 0xdb, 0x00, 0xf3
,2020-03-03 13:22:36.936 Detail, 
,2020-03-03 13:22:36.936 Info, Node007, Response RTT 39 Average Response RTT 42
,2020-03-03 13:22:36.936 Info, Node007, Received Basic report from node 7: level=255
,2020-03-03 13:22:36.936 Detail, Node007, Initial read of value
,2020-03-03 13:22:36.937 Detail, Node007,   Expected reply and command class was received
,2020-03-03 13:22:36.937 Detail, Node007,   Message transaction complete
,2020-03-03 13:22:36.937 Detail, 
,2020-03-03 13:22:36.937 Detail, Node007, Removing current message
,2020-03-03 13:22:36.937 Detail, Node007, Notification: ValueChanged CC: COMMAND_CLASS_BASIC Instance: 1 Index: 0
,2020-03-03 13:22:36.937 Detail, 
,2020-03-03 13:22:36.937 Info, Node007, Sending (Send) message (Callback ID=0x2d, Expected Reply=0x04) - SensorBinaryCmd_Get (Node=7): 0x01, 0x09, 0x00, 0x13, 0x07, 0x02, 0x30, 0x02, 0x25, 0x2d, 0xda
,2020-03-03 13:22:36.937 Info, Node007, Encrypted Flag is 0
,2020-03-03 13:22:36.946 Detail, Node007,   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
,2020-03-03 13:22:36.946 Detail, Node007,   ZW_SEND_DATA delivered to Z-Wave stack
,2020-03-03 13:22:36.966 Detail, Node007,   Received: 0x01, 0x18, 0x00, 0x13, 0x2d, 0x00, 0x00, 0x02, 0x00, 0xdb, 0x7f, 0x7f, 0x7f, 0x7f, 0x00, 0x00, 0x03, 0x00, 0x00, 0x00, 0x00, 0x03, 0x01, 0x00, 0x00, 0x01
,2020-03-03 13:22:36.966 Detail, Node007,   ZW_SEND_DATA Request with callback ID 0x2d received (expected 0x2d)
,2020-03-03 13:22:36.966 Info, Node007, Request RTT 28 Average Request RTT 27
,2020-03-03 13:22:36.966 Detail, Node007, Extended TxStatus: Time: 20, Hops: 0, Rssi:  -37 --- --- --- ---, AckChannel: 0, TxChannel: 0, RouteScheme: Last Working Route, Route: 0 0 0 0, RouteSpeed: 100K, RouteTries: 1, FailedLinkFrom: 0, FailedLinkTo: 0
,2020-03-03 13:22:36.966 Detail, Node007,   Expected callbackId was received
,  z2m:App Zwave api call: _setNodeName [ 7, 'Backdoor' ] +8s
,  z2m:Zwave Success zwave api call _setNodeName true +4s
,  z2m:App Zwave api call: _setNodeLocation [ 7, 'Utilityroom' ] +6s
,  z2m:Zwave Success zwave api call _setNodeLocation true +6s
,2020-03-03 13:22:46.937 Error, Node007, ERROR: Dropping command, expected response not received after 1 attempt(s). Command: "SensorBinaryCmd_Get (Node=7): 0x01, 0x09, 0x00, 0x13, 0x07, 0x02, 0x30, 0x02, 0x25, 0x2d, 0xda"
,2020-03-03 13:22:46.938 Detail, Node007, Removing current message
,2020-03-03 13:22:46.938 Detail, Node007, Notification: Notification - TimeOut
,2020-03-03 13:22:46.938 Detail, 
,2020-03-03 13:22:46.938 Info, Node007, Sending (Send) message (Callback ID=0x2e, Expected Reply=0x04) - AlarmCmd_Get (Node=7): 0x01, 0x0c, 0x00, 0x13, 0x07, 0x05, 0x71, 0x04, 0x00, 0xff, 0x00, 0x25, 0x2e, 0x63
,2020-03-03 13:22:46.938 Info, Node007, Encrypted Flag is 0
,  z2m:Zwave Notification from node 7: Notification - TimeOut (1) +709ms
,2020-03-03 13:22:46.946 Detail, Node007,   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
,2020-03-03 13:22:46.946 Detail, Node007,   ZW_SEND_DATA delivered to Z-Wave stack
,2020-03-03 13:22:46.966 Detail, Node007,   Received: 0x01, 0x18, 0x00, 0x13, 0x2e, 0x00, 0x00, 0x02, 0x00, 0xdb, 0x7f, 0x7f, 0x7f, 0x7f, 0x00, 0x00, 0x03, 0x00, 0x00, 0x00, 0x00, 0x03, 0x01, 0x00, 0x00, 0x02
,2020-03-03 13:22:46.966 Detail, Node007,   ZW_SEND_DATA Request with callback ID 0x2e received (expected 0x2e)
,2020-03-03 13:22:46.967 Info, Node007, Request RTT 28 Average Request RTT 27
,2020-03-03 13:22:46.967 Detail, Node007, Extended TxStatus: Time: 20, Hops: 0, Rssi:  -37 --- --- --- ---, AckChannel: 0, TxChannel: 0, RouteScheme: Last Working Route, Route: 0 0 0 0, RouteSpeed: 100K, RouteTries: 1, FailedLinkFrom: 0, FailedLinkTo: 0
,2020-03-03 13:22:46.967 Detail, Node007,   Expected callbackId was received
,2020-03-03 13:22:47.000 Detail, Node007,   Received: 0x01, 0x0e, 0x00, 0x04, 0x00, 0x07, 0x06, 0x71, 0x05, 0x00, 0x00, 0x00, 0xfe, 0xdb, 0x00, 0xa5
,2020-03-03 13:22:47.000 Detail, 
,2020-03-03 13:22:47.001 Info, Node007, Response RTT 63 Average Response RTT 52
,2020-03-03 13:22:47.001 Info, Node007, Got a AlarmCmd_Report Message.... 
,2020-03-03 13:22:47.001 Warning, Node007, Got a AlarmCmd_Report Message - Greater than Version 2, but size was less than 7?
,2020-03-03 13:22:47.001 Detail, Node007,   Expected reply and command class was received
,2020-03-03 13:22:47.001 Detail, Node007,   Message transaction complete
,2020-03-03 13:22:47.001 Detail, 
,2020-03-03 13:22:47.001 Detail, Node007, Removing current message
,2020-03-03 13:22:47.001 Detail, 
,2020-03-03 13:22:47.001 Info, Node007, Sending (Send) message (Callback ID=0x2f, Expected Reply=0x04) - BatteryCmd_Get (Node=7): 0x01, 0x09, 0x00, 0x13, 0x07, 0x02, 0x80, 0x02, 0x25, 0x2f, 0x68
,2020-03-03 13:22:47.001 Info, Node007, Encrypted Flag is 0
,2020-03-03 13:22:47.009 Detail, Node007,   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
,2020-03-03 13:22:47.009 Detail, Node007,   ZW_SEND_DATA delivered to Z-Wave stack
,2020-03-03 13:22:47.029 Detail, Node007,   Received: 0x01, 0x18, 0x00, 0x13, 0x2f, 0x00, 0x00, 0x02, 0x00, 0xdb, 0x7f, 0x7f, 0x7f, 0x7f, 0x00, 0x00, 0x03, 0x00, 0x00, 0x00, 0x00, 0x03, 0x01, 0x00, 0x00, 0x03
,2020-03-03 13:22:47.030 Detail, Node007,   ZW_SEND_DATA Request with callback ID 0x2f received (expected 0x2f)
,2020-03-03 13:22:47.030 Info, Node007, Request RTT 28 Average Request RTT 27
,2020-03-03 13:22:47.030 Detail, Node007, Extended TxStatus: Time: 20, Hops: 0, Rssi:  -37 --- --- --- ---, AckChannel: 0, TxChannel: 0, RouteScheme: Last Working Route, Route: 0 0 0 0, RouteSpeed: 100K, RouteTries: 1, FailedLinkFrom: 0, FailedLinkTo: 0
,2020-03-03 13:22:47.030 Detail, Node007,   Expected callbackId was received
,2020-03-03 13:22:47.042 Detail, Node007,   Received: 0x01, 0x0b, 0x00, 0x04, 0x00, 0x07, 0x03, 0x80, 0x03, 0x58, 0xdb, 0x00, 0xf4
,2020-03-03 13:22:47.042 Detail, 
,2020-03-03 13:22:47.042 Info, Node007, Response RTT 40 Average Response RTT 46
,2020-03-03 13:22:47.042 Info, Node007, Received Battery report from node 7: level=88
,2020-03-03 13:22:47.042 Detail, Node007, Initial read of value
,2020-03-03 13:22:47.042 Detail, Node007,   Expected reply and command class was received
,2020-03-03 13:22:47.042 Detail, Node007,   Message transaction complete
,2020-03-03 13:22:47.042 Detail, 
,2020-03-03 13:22:47.042 Detail, Node007, Removing current message
,2020-03-03 13:22:47.042 Detail, Node007, Notification: ValueChanged CC: COMMAND_CLASS_BATTERY Instance: 1 Index: 0
,2020-03-03 13:22:47.042 Detail, Node007, Query Stage Complete (Dynamic)
,2020-03-03 13:22:47.042 Detail, Node007, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Configuration live=1
,2020-03-03 13:22:47.042 Detail, Node007, QueryStage_Configuration
,2020-03-03 13:22:47.042 Detail, Node007, QueryStage_Complete
,2020-03-03 13:22:47.042 Detail, Node007, Queuing (WakeUp) WakeUpCmd_NoMoreInformation (Node=7): 0x01, 0x09, 0x00, 0x13, 0x07, 0x02, 0x84, 0x08, 0x25, 0x30, 0x79
,2020-03-03 13:22:47.042 Warning, CheckCompletedNodeQueries m_allNodesQueried=0 m_awakeNodesQueried=1
,2020-03-03 13:22:47.042 Warning, CheckCompletedNodeQueries all=0, deadFound=0 sleepingOnly=1
,2020-03-03 13:22:47.042 Info, Saving Cache
,2020-03-03 13:22:47.042 Info, Node001, Cache Save for Node 1 as its QueryStage_CacheLoad
,2020-03-03 13:22:47.042 Info, Node005, Skipping Cache Save for Node 5 as its not past QueryStage_CacheLoad
,2020-03-03 13:22:47.042 Info, Node006, Skipping Cache Save for Node 6 as its not past QueryStage_CacheLoad
,2020-03-03 13:22:47.043 Info, Node007, Cache Save for Node 7 as its QueryStage_CacheLoad
,2020-03-03 13:22:47.045 Detail, Node007, Notification: NodeQueriesComplete
,2020-03-03 13:22:47.045 Detail, 
,2020-03-03 13:22:47.045 Info, Node007, Sending (WakeUp) message (Callback ID=0x30, Expected Reply=0x13) - WakeUpCmd_NoMoreInformation (Node=7): 0x01, 0x09, 0x00, 0x13, 0x07, 0x02, 0x84, 0x08, 0x25, 0x30, 0x79
,2020-03-03 13:22:47.045 Info, Node007, Encrypted Flag is 0
,  z2m:Zwave node 7 ready: Kaipule Technology Co. Ltd - IM20 Door/Window Sensor (Access Control Sensor) +112ms
,2020-03-03 13:22:47.052 Detail, Node007,   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
,2020-03-03 13:22:47.052 Detail, Node007,   ZW_SEND_DATA delivered to Z-Wave stack
,2020-03-03 13:22:47.072 Detail, Node007,   Received: 0x01, 0x18, 0x00, 0x13, 0x30, 0x00, 0x00, 0x02, 0x00, 0xdb, 0x7f, 0x7f, 0x7f, 0x7f, 0x00, 0x00, 0x03, 0x00, 0x00, 0x00, 0x00, 0x03, 0x01, 0x00, 0x00, 0x1c
,2020-03-03 13:22:47.072 Detail, Node007,   ZW_SEND_DATA Request with callback ID 0x30 received (expected 0x30)
,2020-03-03 13:22:47.072 Info, Node007, Request RTT 27 Average Request RTT 27
,2020-03-03 13:22:47.072 Detail, Node007, Extended TxStatus: Time: 20, Hops: 0, Rssi:  -37 --- --- --- ---, AckChannel: 0, TxChannel: 0, RouteScheme: Last Working Route, Route: 0 0 0 0, RouteSpeed: 100K, RouteTries: 1, FailedLinkFrom: 0, FailedLinkTo: 0
,2020-03-03 13:22:47.072 Info, Node007,   Node 7 has been marked as asleep
,2020-03-03 13:22:47.072 Detail, Node007,   Expected callbackId was received
,2020-03-03 13:22:47.072 Detail, Node007,   Expected reply was received
,2020-03-03 13:22:47.072 Detail, Node007,   Message transaction complete
,2020-03-03 13:22:47.072 Detail, 
,2020-03-03 13:22:47.072 Detail, Node007, Removing current message
,2020-03-03 13:22:47.072 Detail, Node007, Notification: Notification - Node Asleep
,  z2m:Zwave Notification from node 7: Notification - Node Asleep (4) +23ms
,GET / 200 1.507 ms - 1432
,  z2m:App User disconnected JHdR4Ff4_GdA_-x8AAAC +9s
,GET /static/js/manifest.2ae2e69a05c33dfc65f8.js 200 3.226 ms - 857
,GET /static/js/app.e8d7c6e9965f090643b4.js 200 2.041 ms - 72807
,GET /static/css/app.6071a1385bbbf2e6bba673b992155bbf.css 200 5.281 ms - 211451
,GET /static/js/vendor.232393204655456e084d.js 200 2.816 ms - 922715
,  z2m:App New connection aTx2ifs8bbH_XzUTAAAD +217ms
,GET /static/logo.png 200 3.261 ms - 10014
,GET /static/favicons/favicon-32x32.png 200 1.324 ms - 1831
,  z2m:App Zwave api call: healNetwork [] +2s
,2020-03-03 13:22:56.948 Detail, Node001, Queuing (Controller) Request Node Neighbor Update
,2020-03-03 13:22:56.948 Detail, Node005, Queuing (Controller) Request Node Neighbor Update
,2020-03-03 13:22:56.948 Detail, Node006, Queuing (Controller) Request Node Neighbor Update
,2020-03-03 13:22:56.948 Detail, Node007, Queuing (Controller) Request Node Neighbor Update
,2020-03-03 13:22:56.948 Info, Requesting Neighbor Update for node 1
,2020-03-03 13:22:56.949 Detail, Node001, Queuing (Command) ControllerCommand_RequestNodeNeighborUpdate (Node=1): 0x01, 0x05, 0x00, 0x48, 0x01, 0x31, 0x82
,  z2m:Zwave Success zwave api call healNetwork  +10s
,2020-03-03 13:22:56.949 Detail, Node001, Notification: RequestNodeNeighborUpdate ControllerCommand - Starting
,2020-03-03 13:22:56.949 Detail, 
,2020-03-03 13:22:56.949 Info, Node001, Sending (Command) message (Callback ID=0x31, Expected Reply=0x48) - ControllerCommand_RequestNodeNeighborUpdate (Node=1): 0x01, 0x05, 0x00, 0x48, 0x01, 0x31, 0x82
,2020-03-03 13:22:56.949 Info, Node001, Encrypted Flag is 0
,  z2m:Zwave controller command {
,  nodeid: 1,
,  state: 1,
,  errcode: 0,
,  help: 'RequestNodeNeighborUpdate Starting'
,} +1ms
,2020-03-03 13:22:56.979 Detail, Node001,   Received: 0x01, 0x05, 0x00, 0x48, 0x31, 0x23, 0xa0
,2020-03-03 13:22:56.980 Detail, 
,2020-03-03 13:22:56.980 Warning, Node001, WARNING: REQUEST_NEIGHBOR_UPDATE_FAILED
,2020-03-03 13:22:56.980 Detail, Node001,   Expected callbackId was received
,2020-03-03 13:22:56.980 Detail, Node001,   Expected reply was received
,2020-03-03 13:22:56.980 Detail, Node001,   Message transaction complete
,2020-03-03 13:22:56.980 Detail, 
,2020-03-03 13:22:56.980 Detail, Node001, Removing current message
,2020-03-03 13:22:56.980 Detail, Node001, Notification: RequestNodeNeighborUpdate ControllerCommand - Failed
,2020-03-03 13:22:56.980 Info, Requesting Neighbor Update for node 5
,2020-03-03 13:22:56.980 Detail, 
,2020-03-03 13:22:56.980 Detail, Node005, Queuing (Controller) Request Node Neighbor Update
,2020-03-03 13:22:56.980 Detail, Node005, Notification: RequestNodeNeighborUpdate ControllerCommand - Starting
,2020-03-03 13:22:56.980 Detail, Node005, Notification: RequestNodeNeighborUpdate ControllerCommand - Sleeping
,2020-03-03 13:22:56.981 Info, Requesting Neighbor Update for node 6
,2020-03-03 13:22:56.981 Detail, 
,2020-03-03 13:22:56.981 Detail, Node006, Queuing (Controller) Request Node Neighbor Update
,2020-03-03 13:22:56.981 Detail, Node006, Notification: RequestNodeNeighborUpdate ControllerCommand - Starting
,2020-03-03 13:22:56.981 Detail, Node006, Notification: RequestNodeNeighborUpdate ControllerCommand - Sleeping
,2020-03-03 13:22:56.981 Info, Requesting Neighbor Update for node 7
,2020-03-03 13:22:56.981 Detail, 
,  z2m:Zwave controller command {
,  nodeid: 1,
,  state: 8,
,  errcode: 0,
,  help: 'RequestNodeNeighborUpdate Failed'
,} +31ms
,2020-03-03 13:22:56.981 Detail, Node007, Queuing (Controller) Request Node Neighbor Update
,2020-03-03 13:22:56.981 Detail, Node007, Notification: RequestNodeNeighborUpdate ControllerCommand - Starting
,2020-03-03 13:22:56.981 Detail, Node007, Notification: RequestNodeNeighborUpdate ControllerCommand - Sleeping
,  z2m:Zwave controller command {
,  nodeid: 5,
,  state: 1,
,  errcode: 0,
,  help: 'RequestNodeNeighborUpdate Starting'
,} +4ms
,  z2m:Zwave controller command {
,  nodeid: 5,
,  state: 5,
,  errcode: 0,
,  help: 'RequestNodeNeighborUpdate Sleeping'
,} +1ms
,  z2m:Zwave controller command {
,  nodeid: 6,
,  state: 1,
,  errcode: 0,
,  help: 'RequestNodeNeighborUpdate Starting'
,} +2ms
,  z2m:Zwave controller command {
,  nodeid: 6,
,  state: 5,
,  errcode: 0,
,  help: 'RequestNodeNeighborUpdate Sleeping'
,} +1ms
,  z2m:Zwave controller command {
,  nodeid: 7,
,  state: 1,
,  errcode: 0,
,  help: 'RequestNodeNeighborUpdate Starting'
,} +1ms
,  z2m:Zwave controller command {
,  nodeid: 7,
,  state: 5,
,  errcode: 0,
,  help: 'RequestNodeNeighborUpdate Sleeping'
,} +1ms
,2020-03-03 13:22:59.158 Detail, Node007,   Received: 0x01, 0x0b, 0x00, 0x04, 0x00, 0x07, 0x03, 0x80, 0x03, 0x58, 0xd5, 0x00, 0xfa
,2020-03-03 13:22:59.158 Detail, 
,2020-03-03 13:22:59.158 Info, Node007, Received Battery report from node 7: level=88
,2020-03-03 13:22:59.158 Detail, Node007, Refreshed Value: old value=88, new value=88, type=byte
,2020-03-03 13:22:59.158 Detail, Node007, Changes to this value are not verified
,2020-03-03 13:22:59.158 Detail, Node007, Notification: ValueChanged CC: COMMAND_CLASS_BATTERY Instance: 1 Index: 0
,  z2m:Zwave zwave node 7: changed: 128-1-0:Battery Level:88 -> 88 +2s
,2020-03-03 13:22:59.175 Detail, Node007,   Received: 0x01, 0x0a, 0x00, 0x04, 0x00, 0x07, 0x02, 0x84, 0x07, 0xd5, 0x00, 0xa2
,2020-03-03 13:22:59.175 Detail, 
,2020-03-03 13:22:59.176 Info, Node007, Received Wakeup Notification from node 7
,2020-03-03 13:22:59.176 Info, Node007,   Node 7 has been marked as awake
,2020-03-03 13:22:59.176 Detail, Node007, Queuing (Controller) Request Node Neighbor Update
,2020-03-03 13:22:59.176 Detail, Node007, Queuing (WakeUp) WakeUpCmd_NoMoreInformation (Node=7): 0x01, 0x09, 0x00, 0x13, 0x07, 0x02, 0x84, 0x08, 0x25, 0x35, 0x7c
,2020-03-03 13:22:59.176 Detail, Node007, Notification: Notification - Node Awake
,2020-03-03 13:22:59.176 Info, Requesting Neighbor Update for node 7
,2020-03-03 13:22:59.176 Detail, Node007, Queuing (Command) ControllerCommand_RequestNodeNeighborUpdate (Node=7): 0x01, 0x05, 0x00, 0x48, 0x07, 0x36, 0x83
,2020-03-03 13:22:59.176 Detail, Node007, Notification: RequestNodeNeighborUpdate ControllerCommand - Starting
,2020-03-03 13:22:59.176 Detail, 
,2020-03-03 13:22:59.177 Info, Node007, Sending (Command) message (Callback ID=0x36, Expected Reply=0x48) - ControllerCommand_RequestNodeNeighborUpdate (Node=7): 0x01, 0x05, 0x00, 0x48, 0x07, 0x36, 0x83
,2020-03-03 13:22:59.177 Info, Node007, Encrypted Flag is 0
,  z2m:Zwave Notification from node 7: Notification - Node Awake (3) +20ms
,  z2m:Zwave controller command {
,  nodeid: 7,
,  state: 1,
,  errcode: 0,
,  help: 'RequestNodeNeighborUpdate Starting'
,} +1ms
,2020-03-03 13:22:59.208 Detail, Node007,   Received: 0x01, 0x05, 0x00, 0x48, 0x36, 0x21, 0xa5
,2020-03-03 13:22:59.208 Detail, 
,2020-03-03 13:22:59.208 Info, Node007, REQUEST_NEIGHBOR_UPDATE_STARTED
,2020-03-03 13:22:59.208 Detail, Node007,   Expected callbackId was received
,2020-03-03 13:22:59.208 Detail, Node007,   Expected reply was received
,2020-03-03 13:22:59.208 Detail, Node007,   Message transaction complete
,2020-03-03 13:22:59.208 Detail, 
,2020-03-03 13:22:59.208 Detail, Node007, Removing current message
,2020-03-03 13:22:59.208 Detail, Node007, Notification: RequestNodeNeighborUpdate ControllerCommand - InProgress
,2020-03-03 13:22:59.208 Info, WriteNextMsg Controller nothing to do
,  z2m:Zwave controller command {
,  nodeid: 7,
,  state: 6,
,  errcode: 0,
,  help: 'RequestNodeNeighborUpdate InProgress'
,} +29ms
,2020-03-03 13:22:59.483 Detail,   Received: 0x01, 0x05, 0x00, 0x48, 0x36, 0x22, 0xa6
,2020-03-03 13:22:59.483 Detail, 
,2020-03-03 13:22:59.483 Info, REQUEST_NEIGHBOR_UPDATE_DONE
,2020-03-03 13:22:59.483 Detail, Requesting routing info (neighbor list) for Node 7
,2020-03-03 13:22:59.483 Detail, Node007, Queuing (Command) Get Routing Info (Node=7): 0x01, 0x07, 0x00, 0x80, 0x07, 0x00, 0x00, 0x03, 0x7c
,2020-03-03 13:22:59.483 Detail, Node007, Notification: RequestNodeNeighborUpdate ControllerCommand - Completed
,2020-03-03 13:22:59.483 Detail, 
,2020-03-03 13:22:59.483 Info, Node007, Sending (Command) message (Callback ID=0x00, Expected Reply=0x80) - Get Routing Info (Node=7): 0x01, 0x07, 0x00, 0x80, 0x07, 0x00, 0x00, 0x03, 0x7c
,2020-03-03 13:22:59.483 Info, Node007, Encrypted Flag is 0
,  z2m:Zwave controller command {
,  nodeid: 7,
,  state: 7,
,  errcode: 0,
,  help: 'RequestNodeNeighborUpdate Completed'
,} +275ms
,2020-03-03 13:22:59.488 Detail, Node007,   Received: 0x01, 0x20, 0x01, 0x80, 0x01, 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, 0x5f
,2020-03-03 13:22:59.488 Detail, 
,2020-03-03 13:22:59.488 Info, Node007, Received reply to FUNC_ID_ZW_GET_ROUTING_INFO
,2020-03-03 13:22:59.488 Info, Node007,     Neighbors of this node are:
,2020-03-03 13:22:59.488 Info, Node007,     Node 1
,2020-03-03 13:22:59.488 Detail, Node007,   Expected reply was received
,2020-03-03 13:22:59.489 Detail, Node007,   Message transaction complete
,2020-03-03 13:22:59.489 Detail, 
,2020-03-03 13:22:59.489 Detail, Node007, Removing current message
,2020-03-03 13:22:59.489 Detail, 
,2020-03-03 13:22:59.489 Info, Node007, Sending (WakeUp) message (Callback ID=0x35, Expected Reply=0x13) - WakeUpCmd_NoMoreInformation (Node=7): 0x01, 0x09, 0x00, 0x13, 0x07, 0x02, 0x84, 0x08, 0x25, 0x35, 0x7c
,2020-03-03 13:22:59.489 Info, Node007, Encrypted Flag is 0
,2020-03-03 13:22:59.497 Detail, Node007,   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
,2020-03-03 13:22:59.497 Detail, Node007,   ZW_SEND_DATA delivered to Z-Wave stack
,2020-03-03 13:22:59.517 Detail, Node007,   Received: 0x01, 0x18, 0x00, 0x13, 0x35, 0x00, 0x00, 0x02, 0x00, 0xd4, 0x7f, 0x7f, 0x7f, 0x7f, 0x00, 0x00, 0x04, 0x00, 0x00, 0x00, 0x00, 0x03, 0x01, 0x00, 0x00, 0x11
,2020-03-03 13:22:59.517 Detail, Node007,   ZW_SEND_DATA Request with callback ID 0x35 received (expected 0x35)
,2020-03-03 13:22:59.517 Info, Node007, Request RTT 28 Average Request RTT 27
,2020-03-03 13:22:59.517 Detail, Node007, Extended TxStatus: Time: 20, Hops: 0, Rssi:  -44 --- --- --- ---, AckChannel: 0, TxChannel: 0, RouteScheme: Next to Last Working Route, Route: 0 0 0 0, RouteSpeed: 100K, RouteTries: 1, FailedLinkFrom: 0, FailedLinkTo: 0
,2020-03-03 13:22:59.517 Info, Node007,   Node 7 has been marked as asleep
,2020-03-03 13:22:59.517 Detail, Node007,   Expected callbackId was received
,2020-03-03 13:22:59.517 Detail, Node007,   Expected reply was received
,2020-03-03 13:22:59.517 Detail, Node007,   Message transaction complete
,2020-03-03 13:22:59.518 Detail, 
,2020-03-03 13:22:59.518 Detail, Node007, Removing current message
,2020-03-03 13:22:59.518 Detail, Node007, Notification: Notification - Node Asleep
,  z2m:Zwave Notification from node 7: Notification - Node Asleep (4) +37ms
,GET /api/settings 200 29.897 ms - 13581

[Altycoder]

Here's something interesting. For the 3rd sensor I re-added, I ran a heal and woke it up before it died and so far it's still sleeping and the battery level and open/closed are correctly coming through to HA.

Progress!

I'm going to try this with the other two now....

[robertsLando]

@sarkyscouser Keep us updated :)

[robertsLando]

It say openzwave v 1.6.1045 in the dashboard now, can't see any other version numbers in the logs via portainer

Just open the side nav, on the top of the nav you will see also the Z2M version. But if OZW is 1045 it must be the 3.0.0

[Altycoder]

The working sensor has now died too I'm afraid. I can see the v3.0.0 now

[robertsLando]

@sarkyscouser Only @Fishwaldo could help with this so

[Fishwaldo]

OZW_Log.txt please.

[Altycoder]

OZW_Log.txt

[Fishwaldo]

What node? I see Node 6 is still sleeping.

[Altycoder]

They are all dead:

[robertsLando]

@sarkyscouser Please disable refresh node info from gateway settings and retry

[Altycoder]

OK, a bit more progress it seems. I've re-added a sensor and it hasn't died and is correctly reporting it's metrics through to HA. I'll try the others now..... cross your fingers and toes!

[Altycoder]

This is starting to look promising so much so that I'm prepared to trek down to the bottom of the garden in the pouring rain to get my 4th sensor out of the garage!

[Altycoder]

OK looks like it working. It's survived a restart of HA, mosquitto and zwave2mqtt containers, and a reboot of the whole server. If it's still working in the morning it's time to fix all my automations!

Many thanks

[robertsLando]

@sarkyscouser You welcome :)