Node value does not refresh automatically

[macolu]

Hello

I want to mesure gaz consumption in my house. To do so, I started playing with Domoticz and ZWave.

I have the following setup:

• Domoticz v3.5877 on a raspberry pi
• An USB Z-wave controller: Z-Wave.Me ZME_UZB1
• A device that reads gaz meter value: NorthQ NQ-9121

NorthQ device is supposed to wake up every 15 min to send read value.

Configuration went fine: I managed to add Northq node to zwave network and to configure it.
I can see gaz value in "Utility" tab of Domoticz, with m3 conversion. So far so good.

However, value does not update automatically:

• In Utility tab, value and last seen never updates
• In Device list, same thing: last seen and data does not update.
• In "OpenZWave Control Panel" (this URL: /ozwcp/cp.html): last heard updates every 15 min, but value does not.

I have waited about 24 hours, value never updates, while NorthQ device still reads new value from gaz counter.
I have other devices (1-wire, webservices) that updates correctly.

In this "OpenZWave Control Panel", there is a refresh button. If I click on it, then, within the next 15 min, value will update everywhere (including "Utility" tab).


images upload

What did I miss to have automatic value refresh?

I managed to make it work by adding following curl call to crontab, to simulate a click on refresh button every 5 min:

Code: Select all

curl 'http://raspberrypi:8080/ozwcp/refreshpost.html' -H 'Content-Type: application/x-www-form-urlencoded' --data 'fun=racp&node=2'

However, this is clearly not a clean solution

Thanks for your help

[macolu]

Well, after a few hours, value stopped refreshing again. Even my "cron hack" doesn't help now.

I enabled debug mode, here is what I see every 15 min, when NorthQ device wakes up:

2017-03-06 23:20:49.308 Detail, Node002, Received: 0x01, 0x08, 0x00, 0x04, 0x00, 0x02, 0x02, 0x84, 0x07, 0x70
2017-03-06 23:20:49.311 Detail,
2017-03-06 23:20:49.313 Info, Node002, Received Wakeup Notification from node 2
2017-03-06 23:20:49.315 Info, Node002, Node 2 has been marked as awake
2017-03-06 23:20:49.315 Detail, Node002, Queuing (WakeUp) MeterCmd_Get (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x32, 0x01, 0x00, 0x25, 0x0e, 0xff
2017-03-06 23:20:49.317 Detail, Node002, Queuing (WakeUp) BatteryCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x80, 0x02, 0x25, 0x0f, 0x4d
2017-03-06 23:20:49.319 Detail, Node002, Queuing (Query) Query Stage Complete (Dynamic)
2017-03-06 23:20:49.320 Detail, Node002, Notification: Notification - Node Awake
2017-03-06 23:20:49.322 Detail,
2017-03-06 23:20:49.324 Info, Node002, Sending (WakeUp) message (Callback ID=0x0e, Expected Reply=0x04) - MeterCmd_Get (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x32, 0x01, 0x00, 0x25, 0x0e, 0xff
2017-03-06 23:20:49.336 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2017-03-06 23:20:49.339 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2017-03-06 23:20:49.443 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x0e, 0x01, 0x00, 0x0b, 0xef
2017-03-06 23:20:49.445 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x0e received (expected 0x0e)
2017-03-06 23:20:49.446 Info, Node002, WARNING: ZW_SEND_DATA failed. No ACK received - device may be asleep.
2017-03-06 23:20:49.448 Info, Node002, Node 2 has been marked as asleep
2017-03-06 23:20:49.448 Info, Node002, Node not responding - moving message to Wake-Up queue: MeterCmd_Get (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x32, 0x01, 0x00, 0x25, 0x0e, 0xff
2017-03-06 23:20:49.450 Info, Node002, Node not responding - moving message to Wake-Up queue: BatteryCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x80, 0x02, 0x25, 0x0f, 0x4d
2017-03-06 23:20:49.452 Info, Node002, Node not responding - moving QueryStageComplete command to Wake-Up queue
2017-03-06 23:20:49.454 Detail, Node002, Notification: Notification - Node Asleep

And at some point, a miracle happened, and I managed to see read value in debug output (difference is in red):

2017-03-06 22:50:35.458 Detail, Node002, Received: 0x01, 0x08, 0x00, 0x04, 0x00, 0x02, 0x02, 0x84, 0x07, 0x70
2017-03-06 22:50:35.460 Detail,
2017-03-06 22:50:35.462 Info, Node002, Received Wakeup Notification from node 2
2017-03-06 22:50:35.463 Info, Node002, Node 2 has been marked as awake
2017-03-06 22:50:35.464 Detail, Node002, Queuing (WakeUp) MeterCmd_Get (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x32, 0x01, 0x00, 0x25, 0x0e, 0xff
2017-03-06 22:50:35.466 Detail, Node002, Queuing (WakeUp) BatteryCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x80, 0x02, 0x25, 0x0f, 0x4d
2017-03-06 22:50:35.467 Detail, Node002, Queuing (Query) Query Stage Complete (Dynamic)
2017-03-06 22:50:35.469 Detail, Node002, Notification: Notification - Node Awake
2017-03-06 22:50:35.470 Detail,
2017-03-06 22:50:35.472 Info, Node002, Sending (WakeUp) message (Callback ID=0x0e, Expected Reply=0x04) - MeterCmd_Get (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x32, 0x01, 0x00, 0x25, 0x0e, 0xff
2017-03-06 22:50:35.485 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2017-03-06 22:50:35.488 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2017-03-06 22:50:35.518 Detail, Node002, Received: 0x01, 0x14, 0x00, 0x04, 0x00, 0x02, 0x0e, 0x32, 0x02, 0x22, 0x64, 0x00, 0x00, 0x3d, 0x04, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0xac
2017-03-06 22:50:35.520 Detail,
2017-03-06 22:50:35.522 Info, Node002, Response RTT 48 Average Response RTT 48
2017-03-06 22:50:35.522 Detail, Node002, Initial read of value
2017-03-06 22:50:35.524 Info, Node002, Received Meter report from node 2: Gas=15.620cubic meters
2017-03-06 22:50:35.526 Detail, Node002, Initial read of value
2017-03-06 22:50:35.528 Detail, Node002, Notification: ValueChanged
2017-03-06 22:50:35.529 Detail, Node002, Notification: ValueChanged
2017-03-06 22:50:35.592 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x0e, 0x01, 0x00, 0x0c, 0xe8
2017-03-06 22:50:35.596 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x0e received (expected 0x0e)
2017-03-06 22:50:35.598 Info, Node002, WARNING: ZW_SEND_DATA failed. No ACK received - device may be asleep.
2017-03-06 22:50:35.600 Info, Node002, Node 2 has been marked as asleep
2017-03-06 22:50:35.600 Info, Node002, Node not responding - moving message to Wake-Up queue: MeterCmd_Get (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x32, 0x01, 0x00, 0x25, 0x0e, 0xff
2017-03-06 22:50:35.602 Info, Node002, Node not responding - moving message to Wake-Up queue: BatteryCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x80, 0x02, 0x25, 0x0f, 0x4d
2017-03-06 22:50:35.604 Info, Node002, Node not responding - moving QueryStageComplete command to Wake-Up queue
2017-03-06 22:50:35.606 Detail, Node002, Notification: Notification - Node Asleep

However, I don't know how I managed to have this, and I am unable to reproduce it.

Any idea anyone?

Thanks

[mcestoni]

Hello macolu
I have exactly the same problem with a Qubino metter
Did you solve the problem?
Thank you
Mariano

[Egregius]

Could it be that your cron stops because of some kind of authentication in ozwcp?
I mean : open the url in a browser where you didn't open domoticz before. It'll show a blank page.
If I remember correctly you first need to curl the zwave hardware page before calling ozwcp.