Homey sluttet å kjøre flows via Fibaro The Button

[Master Aeon]

Jeg har en "The Button" fra Fibaro som har fungert fint i en måneds tid, men som plutselig bare har sluttet å fungere. Når jeg fjernet den fra Z-Wave nettverket til Homey så reagerte den på at jeg trykket 4 ganger på The Button og fjernet den. Jeg la den til igjen og det fungerte like fint.

 

Jeg oppdaterte så mine 3 flows med "ny" button for 1, 2 og 3 trykk på knappen og prøvde igjen. Fremdeles intet som skjer i Homey. Kjører jeg de aktuelle flows via Test i Homey PC softwaren så fungerer det fint.

 

Jeg prøvde derfor å logge hva som skjer via developer.athom.com så jeg slo på logging under Z-Wave. Deretter gjorde jeg følgende - som faktisk ble logget av Homey, dvs. Homey ser når jeg trykker på The Button, men gidder ikke kjøre de aktuelle flows (som tidligere fungerte fint):

 

- Først 4 trykk for å "vekke opp" knappen ifølge manualen (Node 38 er Fibaro Button):
 

[2018-12-01T14:46:07.689Z] Node[38]: Received application command for COMMAND_CLASS_SECURITY, data: 0x40
[2018-12-01T14:46:07.693Z] Node[38]: [COMMAND_CLASS_SECURITY] {}
[2018-12-01T14:46:07.694Z] Node[38]: [COMMAND_CLASS_SECURITY] [SECURITY_NONCE_REPORT] {"type":"Buffer","data":[97,247,56,238,79,130,208,255]}
[2018-12-01T14:46:07.694Z] Node[38]: sendData to COMMAND_CLASS_SECURITY, params 0x8061f738ee4f82d0ff
[2018-12-01T14:46:07.699Z] Command[222] start: sendData
[2018-12-01T14:46:07.711Z] ProcessSendData[208]: To node: 38 with data: 0x988061f738ee4f82d0ff and txOptions: AUTO_ROUTE,EXPLORE
[2018-12-01T14:46:07.736Z] Command[222] end: sendData
[2018-12-01T14:46:07.754Z] Node[38]: Received application command for COMMAND_CLASS_SECURITY, data: 0x81da3aa0ac10c3d44024bd18f7aa26612c7863f5cb3f12ea
[2018-12-01T14:46:07.755Z] Node[38]: [COMMAND_CLASS_SECURITY] {"Initialization Vector byte":{"type":"Buffer","data":[218,58,160,172,16,195,212,64]},"Properties1 (Raw)":{"type":"Buffer","data":[36]},"Properties1":{"Sequence Counter":4,"Sequenced":false,"Second Frame":true},"Command byte":{"type":"Buffer","data":[189,24,247,170,38]},"Receivers nonce Identifier (Raw)":{"type":"Buffer","data":[97]},"Receivers nonce Identifier":97,"Message Authentication Code byte":{"type":"Buffer","data":[44,120,99,245,203,63,18,234]}}
[2018-12-01T14:46:07.778Z] Node[38]: [COMMAND_CLASS_CENTRAL_SCENE] {"Sequence Number (Raw)":{"type":"Buffer","data":[11]},"Sequence Number":11,"Properties1 (Raw)":{"type":"Buffer","data":[133]},"Properties1":{"Slow Refresh":true,"Key Attributes":"Key Pressed 4 times"},"Scene Number (Raw)":{"type":"Buffer","data":[1]},"Scene Number":1}
[2018-12-01T14:46:07.779Z] Node[38]: Decapsulated frame from COMMAND_CLASS_SECURITY to COMMAND_CLASS_CENTRAL_SCENE, data 0x030b8501

 

- Så ett trykk:

[2018-12-01T14:46:29.064Z] Node[38]: Received application command for COMMAND_CLASS_SECURITY, data: 0x40
[2018-12-01T14:46:29.064Z] Node[38]: [COMMAND_CLASS_SECURITY] {}
[2018-12-01T14:46:29.064Z] Node[38]: [COMMAND_CLASS_SECURITY] [SECURITY_NONCE_REPORT] {"type":"Buffer","data":[98,0,55,152,189,7,204,171]}
[2018-12-01T14:46:29.065Z] Node[38]: sendData to COMMAND_CLASS_SECURITY, params 0x8062003798bd07ccab
[2018-12-01T14:46:29.069Z] Command[223] start: sendData
[2018-12-01T14:46:29.070Z] ProcessSendData[209]: To node: 38 with data: 0x988062003798bd07ccab and txOptions: AUTO_ROUTE,EXPLORE
[2018-12-01T14:46:29.093Z] Command[223] end: sendData
[2018-12-01T14:46:29.115Z] Node[38]: Received application command for COMMAND_CLASS_SECURITY, data: 0x81864515042973ccc3c1005ab9752d62bb4a1bd015f8fafa
[2018-12-01T14:46:29.116Z] Node[38]: [COMMAND_CLASS_SECURITY] {"Initialization Vector byte":{"type":"Buffer","data":[134,69,21,4,41,115,204,195]},"Properties1 (Raw)":{"type":"Buffer","data":[193]},"Properties1":{"Sequence Counter":1,"Sequenced":false,"Second Frame":false},"Command byte":{"type":"Buffer","data":[0,90,185,117,45]},"Receivers nonce Identifier (Raw)":{"type":"Buffer","data":[98]},"Receivers nonce Identifier":98,"Message Authentication Code byte":{"type":"Buffer","data":[187,74,27,208,21,248,250,250]}}
[2018-12-01T14:46:29.129Z] Node[38]: [COMMAND_CLASS_CENTRAL_SCENE] {"Sequence Number (Raw)":{"type":"Buffer","data":[12]},"Sequence Number":12,"Properties1 (Raw)":{"type":"Buffer","data":[128]},"Properties1":{"Slow Refresh":true,"Key Attributes":"Key Pressed 1 time"},"Scene Number (Raw)":{"type":"Buffer","data":[1]},"Scene Number":1}
[2018-12-01T14:46:29.129Z] Node[38]: Decapsulated frame from COMMAND_CLASS_SECURITY to COMMAND_CLASS_CENTRAL_SCENE, data 0x030c8001

- Så 2 trykk for en annen flow:

[2018-12-01T14:46:56.558Z] Node[38]: Received application command for COMMAND_CLASS_SECURITY, data: 0x40
[2018-12-01T14:46:56.559Z] Node[38]: [COMMAND_CLASS_SECURITY] {}
[2018-12-01T14:46:56.559Z] Node[38]: [COMMAND_CLASS_SECURITY] [SECURITY_NONCE_REPORT] {"type":"Buffer","data":[99,212,171,197,27,76,90,24]}
[2018-12-01T14:46:56.559Z] Node[38]: sendData to COMMAND_CLASS_SECURITY, params 0x8063d4abc51b4c5a18
[2018-12-01T14:46:56.567Z] Command[224] start: sendData
[2018-12-01T14:46:56.567Z] ProcessSendData[210]: To node: 38 with data: 0x988063d4abc51b4c5a18 and txOptions: AUTO_ROUTE,EXPLORE
[2018-12-01T14:46:56.586Z] Command[224] end: sendData
[2018-12-01T14:46:56.610Z] Node[38]: Received application command for COMMAND_CLASS_SECURITY, data: 0x818d5b5ae6a77fce77433c78fba64e63415392dc711df0b6
[2018-12-01T14:46:56.611Z] Node[38]: [COMMAND_CLASS_SECURITY] {"Initialization Vector byte":{"type":"Buffer","data":[141,91,90,230,167,127,206,119]},"Properties1 (Raw)":{"type":"Buffer","data":[67]},"Properties1":{"Sequence Counter":3,"Sequenced":false,"Second Frame":false},"Command byte":{"type":"Buffer","data":[60,120,251,166,78]},"Receivers nonce Identifier (Raw)":{"type":"Buffer","data":[99]},"Receivers nonce Identifier":99,"Message Authentication Code byte":{"type":"Buffer","data":[65,83,146,220,113,29,240,182]}}
[2018-12-01T14:46:56.626Z] Node[38]: [COMMAND_CLASS_CENTRAL_SCENE] {"Sequence Number (Raw)":{"type":"Buffer","data":[13]},"Sequence Number":13,"Properties1 (Raw)":{"type":"Buffer","data":[131]},"Properties1":{"Slow Refresh":true,"Key Attributes":"Key Pressed 2 times"},"Scene Number (Raw)":{"type":"Buffer","data":[1]},"Scene Number":1}
[2018-12-01T14:46:56.627Z] Node[38]: Decapsulated frame from COMMAND_CLASS_SECURITY to COMMAND_CLASS_CENTRAL_SCENE, data 0x030d8301

- Så 3 trykk. Homey kjører ingen flows på noen av de:

[2018-12-01T14:47:16.401Z] Node[38]: Received application command for COMMAND_CLASS_SECURITY, data: 0x40
[2018-12-01T14:47:16.401Z] Node[38]: [COMMAND_CLASS_SECURITY] {}
[2018-12-01T14:47:16.402Z] Node[38]: [COMMAND_CLASS_SECURITY] [SECURITY_NONCE_REPORT] {"type":"Buffer","data":[100,218,214,175,94,133,193,248]}
[2018-12-01T14:47:16.402Z] Node[38]: sendData to COMMAND_CLASS_SECURITY, params 0x8064dad6af5e85c1f8
[2018-12-01T14:47:16.407Z] Command[225] start: sendData
[2018-12-01T14:47:16.407Z] ProcessSendData[211]: To node: 38 with data: 0x988064dad6af5e85c1f8 and txOptions: AUTO_ROUTE,EXPLORE
[2018-12-01T14:47:16.426Z] Command[225] end: sendData
[2018-12-01T14:47:16.450Z] Node[38]: Received application command for COMMAND_CLASS_SECURITY, data: 0x818b838cbbfd0c3591f5c649054f2d641469c0c52ea9648b
[2018-12-01T14:47:16.451Z] Node[38]: [COMMAND_CLASS_SECURITY] {"Initialization Vector byte":{"type":"Buffer","data":[139,131,140,187,253,12,53,145]},"Properties1 (Raw)":{"type":"Buffer","data":[245]},"Properties1":{"Sequence Counter":5,"Sequenced":true,"Second Frame":true},"Command byte":{"type":"Buffer","data":[198,73,5,79,45]},"Receivers nonce Identifier (Raw)":{"type":"Buffer","data":[100]},"Receivers nonce Identifier":100,"Message Authentication Code byte":{"type":"Buffer","data":[20,105,192,197,46,169,100,139]}}
[2018-12-01T14:47:16.470Z] Node[38]: [COMMAND_CLASS_CENTRAL_SCENE] {"Sequence Number (Raw)":{"type":"Buffer","data":[14]},"Sequence Number":14,"Properties1 (Raw)":{"type":"Buffer","data":[132]},"Properties1":{"Slow Refresh":true,"Key Attributes":"Key Pressed 3 times"},"Scene Number (Raw)":{"type":"Buffer","data":[1]},"Scene Number":1}
[2018-12-01T14:47:16.471Z] Node[38]: Decapsulated frame from COMMAND_CLASS_SECURITY to COMMAND_CLASS_CENTRAL_SCENE, data 0x030e8401

- Deretter en vellykket av-knapp på NodOn wall switch til slutt, dvs. flow ble kjørt via NodOn-switchen (Node 3):

 

[2018-12-01T14:49:55.910Z] Node[3]: Received application command for COMMAND_CLASS_CENTRAL_SCENE, data: 0x03e10003
[2018-12-01T14:49:55.911Z] Node[3]: [COMMAND_CLASS_CENTRAL_SCENE] {"Sequence Number (Raw)":{"type":"Buffer","data":[225]},"Sequence Number":225,"Properties1 (Raw)":{"type":"Buffer","data":[0]},"Properties1":{"Key Attributes":"Key Pressed 1 time"},"Scene Number (Raw)":{"type":"Buffer","data":[3]},"Scene Number":3}
[2018-12-01T14:49:56.001Z] Node[3]: Received application command for COMMAND_CLASS_WAKE_UP, data: 0x07
[2018-12-01T14:49:56.001Z] Node[3]: [COMMAND_CLASS_WAKE_UP] {}
[2018-12-01T14:49:56.003Z] Node[3]: Marked as online
[2018-12-01T14:49:56.074Z] Node[3]: [COMMAND_CLASS_BATTERY] [BATTERY_GET] {"type":"Buffer","data":[]}
[2018-12-01T14:49:56.075Z] Node[3]: sendData to COMMAND_CLASS_BATTERY, params 0x02
[2018-12-01T14:49:56.076Z] Command[226] start: sendData
[2018-12-01T14:49:56.076Z] ProcessSendData[212]: To node: 3 with data: 0x8002 and txOptions: AUTO_ROUTE,ACK,EXPLORE
[2018-12-01T14:49:56.122Z] Node[9]: [COMMAND_CLASS_SWITCH_MULTILEVEL] [SWITCH_MULTILEVEL_SET] {"type":"Buffer","data":[0]}
[2018-12-01T14:49:56.123Z] Node[9]: sendData to COMMAND_CLASS_SWITCH_MULTILEVEL, params 0x0100
[2018-12-01T14:49:56.126Z] Node[6]: [COMMAND_CLASS_SWITCH_MULTILEVEL] [SWITCH_MULTILEVEL_SET] {"type":"Buffer","data":[0]}
[2018-12-01T14:49:56.127Z] Node[6]: sendData to COMMAND_CLASS_SWITCH_MULTILEVEL, params 0x0100
[2018-12-01T14:49:56.136Z] Node[8]: [COMMAND_CLASS_SWITCH_MULTILEVEL] [SWITCH_MULTILEVEL_SET] {"type":"Buffer","data":[0]}
[2018-12-01T14:49:56.136Z] Node[8]: sendData to COMMAND_CLASS_SWITCH_MULTILEVEL, params 0x0100
[2018-12-01T14:49:56.143Z] Node[36]: [COMMAND_CLASS_SWITCH_BINARY] [SWITCH_BINARY_SET] {"type":"Buffer","data":[0]}
[2018-12-01T14:49:56.143Z] Node[36]: sendData to COMMAND_CLASS_SWITCH_BINARY, params 0x0100
[2018-12-01T14:49:56.144Z] Command[226] end: sendData
[2018-12-01T14:49:56.144Z] Command[227] start: sendData
[2018-12-01T14:49:56.145Z] ProcessSendData[213]: To node: 9 with data: 0x260100 and txOptions: AUTO_ROUTE,ACK,EXPLORE
[2018-12-01T14:49:56.151Z] Node[37]: [COMMAND_CLASS_SWITCH_BINARY] [SWITCH_BINARY_SET] {"type":"Buffer","data":[0]}
[2018-12-01T14:49:56.151Z] Node[37]: sendData to COMMAND_CLASS_SWITCH_BINARY, params 0x0100
[2018-12-01T14:49:56.172Z] Command[227] end: sendData
[2018-12-01T14:49:56.173Z] Command[228] start: sendData
[2018-12-01T14:49:56.173Z] ProcessSendData[214]: To node: 6 with data: 0x260100 and txOptions: AUTO_ROUTE,ACK,EXPLORE
[2018-12-01T14:49:56.243Z] Node[3]: Received application command for COMMAND_CLASS_BATTERY, data: 0x034c
[2018-12-01T14:49:56.244Z] Node[3]: [COMMAND_CLASS_BATTERY] {"Battery Level (Raw)":{"type":"Buffer","data":[76]},"Battery Level":{}}
[2018-12-01T14:49:56.285Z] Node[3]: Received application command for COMMAND_CLASS_BATTERY, data: 0x034c
[2018-12-01T14:49:56.286Z] Node[3]: [COMMAND_CLASS_BATTERY] {"Battery Level (Raw)":{"type":"Buffer","data":[76]},"Battery Level":{}}
[2018-12-01T14:49:56.303Z] Command[228] end: sendData
[2018-12-01T14:49:56.304Z] Command[229] start: sendData
[2018-12-01T14:49:56.304Z] ProcessSendData[215]: To node: 8 with data: 0x260100 and txOptions: AUTO_ROUTE,ACK,EXPLORE
[2018-12-01T14:49:56.340Z] Node[3]: Received application command for COMMAND_CLASS_CENTRAL_SCENE, data: 0x03e10003
[2018-12-01T14:49:56.343Z] Node[3]: [COMMAND_CLASS_CENTRAL_SCENE] {"Sequence Number (Raw)":{"type":"Buffer","data":[225]},"Sequence Number":225,"Properties1 (Raw)":{"type":"Buffer","data":[0]},"Properties1":{"Key Attributes":"Key Pressed 1 time"},"Scene Number (Raw)":{"type":"Buffer","data":[3]},"Scene Number":3}
[2018-12-01T14:49:56.532Z] Node[3]: Received application command for COMMAND_CLASS_CENTRAL_SCENE, data: 0x03e10003
[2018-12-01T14:49:56.533Z] Node[3]: [COMMAND_CLASS_CENTRAL_SCENE] {"Sequence Number (Raw)":{"type":"Buffer","data":[225]},"Sequence Number":225,"Properties1 (Raw)":{"type":"Buffer","data":[0]},"Properties1":{"Key Attributes":"Key Pressed 1 time"},"Scene Number (Raw)":{"type":"Buffer","data":[3]},"Scene Number":3}
[2018-12-01T14:49:56.575Z] Node[3]: Received application command for COMMAND_CLASS_CENTRAL_SCENE, data: 0x03e10003
[2018-12-01T14:49:56.575Z] Node[3]: [COMMAND_CLASS_CENTRAL_SCENE] {"Sequence Number (Raw)":{"type":"Buffer","data":[225]},"Sequence Number":225,"Properties1 (Raw)":{"type":"Buffer","data":[0]},"Properties1":{"Key Attributes":"Key Pressed 1 time"},"Scene Number (Raw)":{"type":"Buffer","data":[3]},"Scene Number":3}
[2018-12-01T14:49:56.611Z] Command[229] end: sendData
[2018-12-01T14:49:56.611Z] Command[230] start: sendData
[2018-12-01T14:49:56.612Z] ProcessSendData[216]: To node: 36 with data: 0x250100 and txOptions: AUTO_ROUTE,ACK,EXPLORE
[2018-12-01T14:49:56.720Z] Command[230] end: sendData
[2018-12-01T14:49:56.721Z] Command[231] start: sendData
[2018-12-01T14:49:56.721Z] ProcessSendData[217]: To node: 37 with data: 0x250100 and txOptions: AUTO_ROUTE,ACK,EXPLORE
[2018-12-01T14:49:56.789Z] Node[36]: Received application command for COMMAND_CLASS_SWITCH_BINARY, data: 0x0300
[2018-12-01T14:49:56.789Z] Node[36]: [COMMAND_CLASS_SWITCH_BINARY] {"Value (Raw)":{"type":"Buffer","data":[0]},"Value":"off/disable"}
[2018-12-01T14:49:56.832Z] Command[231] end: sendData
[2018-12-01T14:49:56.857Z] Node[37]: Received application command for COMMAND_CLASS_SWITCH_BINARY, data: 0x0300
[2018-12-01T14:49:56.857Z] Node[37]: [COMMAND_CLASS_SWITCH_BINARY] {"Value (Raw)":{"type":"Buffer","data":[0]},"Value":"off/disable"}
[2018-12-01T14:49:59.506Z] Node[3]: [COMMAND_CLASS_WAKE_UP] [WAKE_UP_NO_MORE_INFORMATION] {"type":"Buffer","data":[]}
[2018-12-01T14:49:59.506Z] Node[3]: sendData to COMMAND_CLASS_WAKE_UP, params 0x08
[2018-12-01T14:49:59.511Z] Command[232] start: sendData
[2018-12-01T14:49:59.512Z] ProcessSendData[218]: To node: 3 with data: 0x8408 and txOptions: AUTO_ROUTE,ACK,EXPLORE
[2018-12-01T14:49:59.571Z] Node[36]: Received application command for COMMAND_CLASS_METER, data: 0x0221140000000b01f70000001200
[2018-12-01T14:49:59.574Z] Node[36]: [COMMAND_CLASS_METER] {"Properties1 (Raw)":{"type":"Buffer","data":[33]},"Properties1":{"Scale bit 2":false,"Meter Type":"Electric meter","Rate Type":"Import","Meter Type (Parsed)":{"value":"Electric meter"},"Rate Type (Parsed)":{"value":"Import"}},"Properties2 (Raw)":{"type":"Buffer","data":[20]},"Properties2":{"Size":4,"Scale bits 10":2,"Precision":0},"Meter Value":{"type":"Buffer","data":[0,0,0,11]},"Delta Time (Raw)":{"type":"Buffer","data":[1,247]},"Delta Time":503,"Previous Meter Value":{"type":"Buffer","data":[0,0,0,18]},"Scale 2 (Raw)":{"type":"Buffer","data":[0]},"Scale 2":0,"Meter Value (Parsed)":11,"Previous Meter Value (Parsed)":18}
[2018-12-01T14:49:59.674Z] Node[36]: Received application command for COMMAND_CLASS_METER, data: 0x0221140000000b01f70000001200
[2018-12-01T14:49:59.675Z] Node[36]: [COMMAND_CLASS_METER] {"Properties1 (Raw)":{"type":"Buffer","data":[33]},"Properties1":{"Scale bit 2":false,"Meter Type":"Electric meter","Rate Type":"Import","Meter Type (Parsed)":{"value":"Electric meter"},"Rate Type (Parsed)":{"value":"Import"}},"Properties2 (Raw)":{"type":"Buffer","data":[20]},"Properties2":{"Size":4,"Scale bits 10":2,"Precision":0},"Meter Value":{"type":"Buffer","data":[0,0,0,11]},"Delta Time (Raw)":{"type":"Buffer","data":[1,247]},"Delta Time":503,"Previous Meter Value":{"type":"Buffer","data":[0,0,0,18]},"Scale 2 (Raw)":{"type":"Buffer","data":[0]},"Scale 2":0,"Meter Value (Parsed)":11,"Previous Meter Value (Parsed)":18}
[2018-12-01T14:49:59.728Z] Node[37]: Received application command for COMMAND_CLASS_METER, data: 0x0221140000000d01f50000001400
[2018-12-01T14:49:59.730Z] Node[37]: [COMMAND_CLASS_METER] {"Properties1 (Raw)":{"type":"Buffer","data":[33]},"Properties1":{"Scale bit 2":false,"Meter Type":"Electric meter","Rate Type":"Import","Meter Type (Parsed)":{"value":"Electric meter"},"Rate Type (Parsed)":{"value":"Import"}},"Properties2 (Raw)":{"type":"Buffer","data":[20]},"Properties2":{"Size":4,"Scale bits 10":2,"Precision":0},"Meter Value":{"type":"Buffer","data":[0,0,0,13]},"Delta Time (Raw)":{"type":"Buffer","data":[1,245]},"Delta Time":501,"Previous Meter Value":{"type":"Buffer","data":[0,0,0,20]},"Scale 2 (Raw)":{"type":"Buffer","data":[0]},"Scale 2":0,"Meter Value (Parsed)":13,"Previous Meter Value (Parsed)":20}
[2018-12-01T14:49:59.785Z] Node[37]: Received application command for COMMAND_CLASS_METER, data: 0x0221140000000d01f50000001400
[2018-12-01T14:49:59.786Z] Node[37]: [COMMAND_CLASS_METER] {"Properties1 (Raw)":{"type":"Buffer","data":[33]},"Properties1":{"Scale bit 2":false,"Meter Type":"Electric meter","Rate Type":"Import","Meter Type (Parsed)":{"value":"Electric meter"},"Rate Type (Parsed)":{"value":"Import"}},"Properties2 (Raw)":{"type":"Buffer","data":[20]},"Properties2":{"Size":4,"Scale bits 10":2,"Precision":0},"Meter Value":{"type":"Buffer","data":[0,0,0,13]},"Delta Time (Raw)":{"type":"Buffer","data":[1,245]},"Delta Time":501,"Previous Meter Value":{"type":"Buffer","data":[0,0,0,20]},"Scale 2 (Raw)":{"type":"Buffer","data":[0]},"Scale 2":0,"Meter Value (Parsed)":13,"Previous Meter Value (Parsed)":20}
[2018-12-01T14:50:00.051Z] Command[232] end: sendData
[2018-12-01T14:50:00.052Z] Node[3]: Marked as offline

 

Hva skal man se etter i disse loggene?

Jeg har ingen erfaring på å trace disse loggene så om noen kan peke ut hva jeg skal se etter så setter jeg stor pris på det. Eksempelvis kommer det frem et sted i loggen at den ikke greier å kjøre en flow? Ser man i den siste loggen for veggbryteren NodOn at alt gikk ok for sammenligningens skyld?