[ NUKI Smartlock ] 73_NUKIBridge.pm und 74_NUKDevice.pm

fred_feuerstein · 10 November 2016, 19:38:23

Ah, das wusste ich nicht, dass das Update auch wieder die Version downgraden kann. Prima.

>> gesendet mit LG G4 via Tapatalk <<

Cobra · 11 November 2016, 17:46:42

Hey CoolTux,

mir ist leider noch ein anderes Problem mit meinem SmartLock aufgefallen.
Sporadisch nimmt es keine Lock/Unlock-Befehle an.
Passiert dann als auch gerne mal dass ich z.B. auf der Fernbedienung 2 mal drücken muss damit er den Befehl ausführt.

Ich hatte das Glück dass ich mit Verbose 5 etwas im Log aufzeichnen konnte als er einen Befehl den ich direkt aus FHEMWEB abgesetzt habe nicht umgesetzt hat:

Code Auswählen

2016.11.11 17:31:27 5: parse status message for NUKIDevice102844921
2016.11.11 17:31:27 3: NUKIDevice (NUKIDevice102844921) - JSON2: battery 0 und success 1
2016.11.11 17:31:27 3: NUKIDevice (NUKIDevice102844921) - JSON: {"state": 1, "stateName": "locked", "batteryCritical": false, "success": true}
2016.11.11 17:31:25 5: NUKIDevice (NUKIDevice102844921) - Call InternalTimer
2016.11.11 17:31:25 5: NUKIDevice (NUKIDevice102844921) - Call NUKIDevice_GetUpdate
2016.11.11 17:31:25 5: NUKIDevice (NUKIDevice102844921) - NUKIDevice_GetUpdate Call NUKIDevice_ReadFromNUKIBridge
2016.11.11 17:31:25 4: NUKIBridge (NBridge1) - Send HTTP POST with URL http://192.168.178.56:8080/lockState?token=xxxx&nukiId=102844921
2016.11.11 17:31:09 4: NUKIBridge (NBridge1) - error while requesting: read from http://192.168.178.56:8080 timed out
2016.11.11 17:31:05 4: NUKIBridge (NBridge1) - error while requesting: http://192.168.178.56:8080/lockState?token=xxxx&nukiId=102844921: empty answer received
2016.11.11 17:31:05 5: NUKIDevice (NUKIDevice102844921) - Call InternalTimer
2016.11.11 17:31:05 5: NUKIDevice (NUKIDevice102844921) - Call NUKIDevice_GetUpdate
2016.11.11 17:31:05 5: NUKIDevice (NUKIDevice102844921) - NUKIDevice_GetUpdate Call NUKIDevice_ReadFromNUKIBridge
2016.11.11 17:31:05 4: NUKIBridge (NBridge1) - Send HTTP POST with URL http://192.168.178.56:8080/lockState?token=Fxxxx&nukiId=102844921
2016.11.11 17:30:59 4: NUKIBridge (NBridge1) - Send HTTP POST with URL http://192.168.178.56:8080/lockAction?token=xxxx&action=2&nukiId=102844921
2016.11.11 17:30:55 4: NUKIBridge (NBridge1) - Bridge ist offline
2016.11.11 17:30:45 4: NUKIBridge (NBridge1) - error while requesting: http://192.168.178.56:8080/lockState?token=xxxx&nukiId=102844921: empty answer received
2016.11.11 17:30:45 5: NUKIDevice (NUKIDevice102844921) - Call InternalTimer
2016.11.11 17:30:45 5: NUKIDevice (NUKIDevice102844921) - Call NUKIDevice_GetUpdate
2016.11.11 17:30:45 5: NUKIDevice (NUKIDevice102844921) - NUKIDevice_GetUpdate Call NUKIDevice_ReadFromNUKIBridge
2016.11.11 17:30:45 4: NUKIBridge (NBridge1) - Send HTTP POST with URL http://192.168.178.56:8080/lockState?token=xxxx&nukiId=102844921
2016.11.11 17:30:44 4: NUKIBridge (NBridge1) - Call InternalTimer for NUKIBridge_GetCheckBridgeAlive
2016.11.11 17:30:44 4: NUKIBridge (NBridge1) - Send HTTP POST with URL http://192.168.178.56:8080/list?token=xxxx
2016.11.11 17:30:24 5: readings set for NUKIDevice102844921
2016.11.11 17:30:24 5: parse status message for NUKIDevice102844921
2016.11.11 17:30:24 3: NUKIDevice (NUKIDevice102844921) - JSON2: battery 0 und success 1
2016.11.11 17:30:24 3: NUKIDevice (NUKIDevice102844921) - JSON: {"state": 3, "stateName": "unlocked", "batteryCritical": false, "success": true}
2016.11.11 17:30:22 5: NUKIDevice (NUKIDevice102844921) - Call InternalTimer
2016.11.11 17:30:22 5: NUKIDevice (NUKIDevice102844921) - Call NUKIDevice_GetUpdate
2016.11.11 17:30:22 5: NUKIDevice (NUKIDevice102844921) - NUKIDevice_GetUpdate Call NUKIDevice_ReadFromNUKIBridge
2016.11.11 17:30:22 4: NUKIBridge (NBridge1) - Send HTTP POST with URL http://192.168.178.56:8080/lockState?token=xxxx&nukiId=102844921
2016.11.11 17:30:05 5: parse status message for NUKIDevice102844921
2016.11.11 17:30:05 3: NUKIDevice (NUKIDevice102844921) - JSON2: battery 0 und success 1
2016.11.11 17:30:05 3: NUKIDevice (NUKIDevice102844921) - JSON: {"state": 3, "stateName": "unlocked", "batteryCritical": false, "success": true}
2016.11.11 17:30:02 5: NUKIDevice (NUKIDevice102844921) - Call InternalTimer
2016.11.11 17:30:02 5: NUKIDevice (NUKIDevice102844921) - Call NUKIDevice_GetUpdate
2016.11.11 17:30:02 5: NUKIDevice (NUKIDevice102844921) - NUKIDevice_GetUpdate Call NUKIDevice_ReadFromNUKIBridge
2016.11.11 17:30:02 4: NUKIBridge (NBridge1) - Send HTTP POST with URL http://192.168.178.56:8080/lockState?token=xxxx&nukiId=102844921
2016.11.11 17:29:52 4: NUKIBridge (NBridge1) - Bridge ist offline
2016.11.11 17:29:50 4: NUKIBridge (NBridge1) - error while requesting: http://192.168.178.56:8080/lockAction?token=xxxx&action=2&nukiId=102844921: empty answer received
2016.11.11 17:29:50 4: NUKIBridge (NBridge1) - Send HTTP POST with URL http://192.168.178.56:8080/lockAction?token=xxxx&action=2&nukiId=102844921

Bei 17:29:50 habe ich set NUKIDevice102844921 lock abgesetzt.
Kurz danach habe ich den gleichen Befehl nochmal ausgeführt und dann hat es geklappt.

Fällt dir viellleicht auf woran das liegen könnte? Mir kommt es vor wie wenn die Bridge in einen Schlafmodus geht und erst geweckt werden muss. (Allerdings auch nicht immer)
Jeder weitere Befehl nach dem ersten Fehlversuch wird nämlich ohne Probleme ausgeführt.

Gruß Cobra

CoolTux · 11 November 2016, 18:13:38

Hallo Cobra,

Schaue ich mir gleich in Ruhe an aber bitte schau du mal ob Du im Log der Bridge etwas findest.

Einfach mit einem Browser

http://192.168.178.56:8080/log?token=xxxx

Cobra · 11 November 2016, 18:49:38

Bekomme folgende Logeinträge:

Code Auswählen

[
{"timestamp": "2016-11-11T17:45:57+00:00", "type": "WLAN-SocketConnected", "connection": 0},
{"timestamp": "2016-11-11T17:45:41+00:00", "type": "WLAN-SocketDisconnected", "connection": 0},
{"timestamp": "2016-11-11T17:45:41+00:00", "type": "BLE-Disconnected", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T17:45:40+00:00", "type": "BLE-ReceivingMsg", "nukiId": "062149F9", "cmdId": "000C"},
{"timestamp": "2016-11-11T17:45:39+00:00", "type": "BLE-SendingMsg", "nukiId": "062149F9", "cmdId": "0001"},
{"timestamp": "2016-11-11T17:45:39+00:00", "type": "BLE-Connect", "handles": [24, 28]},
{"timestamp": "2016-11-11T17:45:39+00:00", "type": "BLE-Connected", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T17:45:38+00:00", "type": "BLE-Connect", "macAddr": "54D2722149F9"},
{"timestamp": "2016-11-11T17:45:38+00:00", "type": "BLE-Connect", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T17:45:38+00:00", "type": "HTTP-LockState", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T17:45:38+00:00", "type": "WLAN-SocketConnected", "connection": 0},
{"timestamp": "2016-11-11T17:45:28+00:00", "type": "WLAN-SocketDisconnected", "connection": 0},
{"timestamp": "2016-11-11T17:45:18+00:00", "type": "HTTP-List"},
{"timestamp": "2016-11-11T17:45:18+00:00", "type": "WLAN-SocketConnected", "connection": 0},
{"timestamp": "2016-11-11T17:44:58+00:00", "type": "WLAN-SocketDisconnected", "connection": 0},
{"timestamp": "2016-11-11T17:44:58+00:00", "type": "BLE-Disconnected", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T17:44:35+00:00", "type": "BLE-Connect", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T17:44:35+00:00", "type": "HTTP-LockState", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T17:44:35+00:00", "type": "WLAN-SocketConnected", "connection": 0},
{"timestamp": "2016-11-11T17:44:25+00:00", "type": "WLAN-SocketDisconnected", "connection": 0},
{"timestamp": "2016-11-11T17:44:15+00:00", "type": "HTTP-List"},
{"timestamp": "2016-11-11T17:44:15+00:00", "type": "WLAN-SocketConnected", "connection": 0},
{"timestamp": "2016-11-11T17:43:54+00:00", "type": "WLAN-SocketDisconnected", "connection": 0},
{"timestamp": "2016-11-11T17:43:54+00:00", "type": "BLE-Disconnected", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T17:43:53+00:00", "type": "BLE-ReceivingMsg", "nukiId": "062149F9", "cmdId": "000C"},
{"timestamp": "2016-11-11T17:43:53+00:00", "type": "BLE-SendingMsg", "nukiId": "062149F9", "cmdId": "0001"},
{"timestamp": "2016-11-11T17:43:53+00:00", "type": "BLE-Connect", "handles": [24, 28]},
{"timestamp": "2016-11-11T17:43:52+00:00", "type": "BLE-Connected", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T17:43:52+00:00", "type": "BLE-Connect", "macAddr": "54D2722149F9"},
{"timestamp": "2016-11-11T17:43:52+00:00", "type": "BLE-Connect", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T17:43:52+00:00", "type": "HTTP-LockState", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T17:43:52+00:00", "type": "WLAN-SocketConnected", "connection": 0},
{"timestamp": "2016-11-11T17:43:35+00:00", "type": "WLAN-SocketDisconnected", "connection": 0},
{"timestamp": "2016-11-11T17:43:35+00:00", "type": "BLE-Disconnected", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T17:43:34+00:00", "type": "BLE-ReceivingMsg", "nukiId": "062149F9", "cmdId": "000C"},
{"timestamp": "2016-11-11T17:43:33+00:00", "type": "BLE-SendingMsg", "nukiId": "062149F9", "cmdId": "0001"},
{"timestamp": "2016-11-11T17:43:33+00:00", "type": "BLE-Connect", "handles": [24, 28]},
{"timestamp": "2016-11-11T17:43:33+00:00", "type": "BLE-Connected", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T17:43:32+00:00", "type": "BLE-Connect", "macAddr": "54D2722149F9"},
{"timestamp": "2016-11-11T17:43:32+00:00", "type": "BLE-Connect", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T17:43:32+00:00", "type": "HTTP-LockState", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T17:43:32+00:00", "type": "WLAN-SocketConnected", "connection": 0},
{"timestamp": "2016-11-11T17:43:22+00:00", "type": "WLAN-SocketDisconnected", "connection": 0},
{"timestamp": "2016-11-11T17:43:12+00:00", "type": "HTTP-List"},
{"timestamp": "2016-11-11T17:43:12+00:00", "type": "WLAN-SocketConnected", "connection": 0},
{"timestamp": "2016-11-11T17:42:52+00:00", "type": "WLAN-SocketDisconnected", "connection": 0},
{"timestamp": "2016-11-11T17:42:52+00:00", "type": "BLE-Disconnected", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T17:42:51+00:00", "type": "BLE-ReceivingMsg", "nukiId": "062149F9", "cmdId": "000C"},
{"timestamp": "2016-11-11T17:42:50+00:00", "type": "BLE-SendingMsg", "nukiId": "062149F9", "cmdId": "0001"},
{"timestamp": "2016-11-11T17:42:50+00:00", "type": "BLE-Connect", "handles": [24, 28]},
{"timestamp": "2016-11-11T17:42:50+00:00", "type": "BLE-Connected", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T17:42:49+00:00", "type": "BLE-Connect", "macAddr": "54D2722149F9"},
{"timestamp": "2016-11-11T17:42:49+00:00", "type": "BLE-Connect", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T17:42:49+00:00", "type": "HTTP-LockState", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T17:42:49+00:00", "type": "WLAN-SocketConnected", "connection": 0},
{"timestamp": "2016-11-11T17:42:33+00:00", "type": "WLAN-SocketDisconnected", "connection": 0},
{"timestamp": "2016-11-11T17:42:33+00:00", "type": "BLE-Disconnected", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T17:42:31+00:00", "type": "BLE-ReceivingMsg", "nukiId": "062149F9", "cmdId": "000C"},
{"timestamp": "2016-11-11T17:42:30+00:00", "type": "BLE-SendingMsg", "nukiId": "062149F9", "cmdId": "0001"},
{"timestamp": "2016-11-11T17:42:30+00:00", "type": "BLE-Connect", "handles": [24, 28]},
{"timestamp": "2016-11-11T17:42:30+00:00", "type": "BLE-Connected", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T17:42:29+00:00", "type": "BLE-Connect", "macAddr": "54D2722149F9"},
{"timestamp": "2016-11-11T17:42:29+00:00", "type": "BLE-Connect", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T17:42:29+00:00", "type": "HTTP-LockState", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T17:42:29+00:00", "type": "WLAN-SocketConnected", "connection": 0},
{"timestamp": "2016-11-11T17:42:20+00:00", "type": "WLAN-SocketDisconnected", "connection": 0},
{"timestamp": "2016-11-11T17:42:10+00:00", "type": "HTTP-List"},
{"timestamp": "2016-11-11T17:42:09+00:00", "type": "WLAN-SocketConnected", "connection": 0},
{"timestamp": "2016-11-11T17:41:49+00:00", "type": "WLAN-SocketDisconnected", "connection": 0},
{"timestamp": "2016-11-11T17:41:49+00:00", "type": "BLE-Disconnected", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T17:41:47+00:00", "type": "BLE-ReceivingMsg", "nukiId": "062149F9", "cmdId": "000C"},
{"timestamp": "2016-11-11T17:41:47+00:00", "type": "BLE-SendingMsg", "nukiId": "062149F9", "cmdId": "0001"},
{"timestamp": "2016-11-11T17:41:47+00:00", "type": "BLE-Connect", "handles": [24, 28]},
{"timestamp": "2016-11-11T17:41:47+00:00", "type": "BLE-Connected", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T17:41:46+00:00", "type": "BLE-Connect", "macAddr": "54D2722149F9"},
{"timestamp": "2016-11-11T17:41:46+00:00", "type": "BLE-Connect", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T17:41:46+00:00", "type": "HTTP-LockState", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T17:41:46+00:00", "type": "WLAN-SocketConnected", "connection": 0},
{"timestamp": "2016-11-11T17:41:29+00:00", "type": "WLAN-SocketDisconnected", "connection": 0},
{"timestamp": "2016-11-11T17:41:29+00:00", "type": "BLE-Disconnected", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T17:41:28+00:00", "type": "BLE-ReceivingMsg", "nukiId": "062149F9", "cmdId": "000C"},
{"timestamp": "2016-11-11T17:41:27+00:00", "type": "BLE-SendingMsg", "nukiId": "062149F9", "cmdId": "0001"},
{"timestamp": "2016-11-11T17:41:27+00:00", "type": "BLE-Connect", "handles": [24, 28]},
{"timestamp": "2016-11-11T17:41:27+00:00", "type": "BLE-Connected", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T17:41:26+00:00", "type": "BLE-Connect", "macAddr": "54D2722149F9"}
]

Wenn ich das richtig interpretiere verliert er immer mal wieder WLAN und Bluetooth-Verbindung? Hm...

CoolTux · 11 November 2016, 19:27:20

Schade die Zeiten passen nicht. Also dein Log ist von einem späteren Zeitpunkt wie der Modullog. Aber die WLan disconnects wären eine Möglichkeit.

Cobra · 11 November 2016, 19:46:45

Leider zeigt er mir unter dem Link immer nur das Log von 2 Minuten

Wird natürlich schwer den nächsten Zeitpunkt genau abzupassen, ich werd jetzt mal ab und zu versuchen heut abend und wenn es dann wieder vorkommt gleich mal das Log der Bridge auch rauszukopieren. Reicht dir Verbose 3 dann oder sollte es Verbose 5 sein (Log wird ja ziemlich voll dadurch

)

Das mit dem WLAN versteh ich auch nicht ganz, Verbindung zum Router sollte von der Reichweite her passen und laut FritzBIx gibt es hier keine Meldungen dass sich die Bridge immer wieder neu anmelden würde

Cobra · 11 November 2016, 19:52:31

Ok, hat doch gleich geklappt, die Disconnects kommen ja fast immer ungefähr zum selben Zeitpunkt:

Log FHEM:

Code Auswählen

2016.11.11 19:48:29 4: NUKIBridge (NBridge1) - Bridge ist offline
2016.11.11 19:48:22 5: readings set for NUKIDevice102844921
2016.11.11 19:48:22 5: parse status message for NUKIDevice102844921
2016.11.11 19:48:22 3: NUKIDevice (NUKIDevice102844921) - JSON2: battery 0 und success 1
2016.11.11 19:48:22 3: NUKIDevice (NUKIDevice102844921) - JSON: {"state": 1, "stateName": "locked", "batteryCritical": false, "success": true}
2016.11.11 19:48:19 5: NUKIDevice (NUKIDevice102844921) - Call InternalTimer
2016.11.11 19:48:19 5: NUKIDevice (NUKIDevice102844921) - Call NUKIDevice_GetUpdate
2016.11.11 19:48:19 5: NUKIDevice (NUKIDevice102844921) - NUKIDevice_GetUpdate Call NUKIDevice_ReadFromNUKIBridge
2016.11.11 19:48:19 4: NUKIBridge (NBridge1) - Send HTTP POST with URL http://192.168.178.56:8080/lockState?token=FX0dQQ&nukiId=102844921
2016.11.11 19:48:19 4: NUKIBridge (NBridge1) - Call InternalTimer for NUKIBridge_GetCheckBridgeAlive
2016.11.11 19:48:19 4: NUKIBridge (NBridge1) - Send HTTP POST with URL http://192.168.178.56:8080/list?token=FX0dQQ
2016.11.11 19:47:59 5: parse status message for NUKIDevice102844921
2016.11.11 19:47:59 3: NUKIDevice (NUKIDevice102844921) - JSON2: battery 0 und success 1
2016.11.11 19:47:59 3: NUKIDevice (NUKIDevice102844921) - JSON: {"state": 1, "stateName": "locked", "batteryCritical": false, "success": true}
2016.11.11 19:47:57 4: NUKIBridge (NBridge1) - error while requesting: http://192.168.178.56:8080/lockAction?token=FX0dQQ&action=1&nukiId=102844921: empty answer received
2016.11.11 19:47:57 4: NUKIBridge (NBridge1) - Send HTTP POST with URL http://192.168.178.56:8080/lockAction?token=FX0dQQ&action=1&nukiId=102844921
2016.11.11 19:47:56 5: NUKIDevice (NUKIDevice102844921) - Call InternalTimer
2016.11.11 19:47:56 5: NUKIDevice (NUKIDevice102844921) - Call NUKIDevice_GetUpdate
2016.11.11 19:47:56 5: NUKIDevice (NUKIDevice102844921) - NUKIDevice_GetUpdate Call NUKIDevice_ReadFromNUKIBridge
2016.11.11 19:47:56 4: NUKIBridge (NBridge1) - Send HTTP POST with URL http://192.168.178.56:8080/lockState?token=FX0dQQ&nukiId=102844921

Log Bridge:

Code Auswählen

[
{"timestamp": "2016-11-11T18:48:18+00:00", "type": "WLAN-SocketConnected", "connection": 0},
{"timestamp": "2016-11-11T18:48:10+00:00", "type": "WLAN-SocketDisconnected", "connection": 0},
{"timestamp": "2016-11-11T18:48:09+00:00", "type": "WLAN-TxDropped", "connection": 0, "bytes": 1509},
{"timestamp": "2016-11-11T18:48:09+00:00", "type": "WLAN-SocketConnected", "connection": 0},
{"timestamp": "2016-11-11T18:47:59+00:00", "type": "WLAN-SocketDisconnected", "connection": 0},
{"timestamp": "2016-11-11T18:47:59+00:00", "type": "BLE-Disconnected", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T18:47:57+00:00", "type": "BLE-ReceivingMsg", "nukiId": "062149F9", "cmdId": "000C"},
{"timestamp": "2016-11-11T18:47:56+00:00", "type": "BLE-SendingMsg", "nukiId": "062149F9", "cmdId": "0001"},
{"timestamp": "2016-11-11T18:47:56+00:00", "type": "BLE-Connect", "handles": [24, 28]},
{"timestamp": "2016-11-11T18:47:56+00:00", "type": "BLE-Connected", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T18:47:56+00:00", "type": "BLE-Connect", "macAddr": "54D2722149F9"},
{"timestamp": "2016-11-11T18:47:56+00:00", "type": "BLE-Connect", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T18:47:56+00:00", "type": "HTTP-LockState", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T18:47:56+00:00", "type": "WLAN-SocketConnected", "connection": 0},
{"timestamp": "2016-11-11T18:47:39+00:00", "type": "WLAN-SocketDisconnected", "connection": 0},
{"timestamp": "2016-11-11T18:46:55+00:00", "type": "BLE-Disconnected", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T18:46:54+00:00", "type": "BLE-ReceivingMsg", "nukiId": "062149F9", "cmdId": "000C"},
{"timestamp": "2016-11-11T18:46:53+00:00", "type": "BLE-SendingMsg", "nukiId": "062149F9", "cmdId": "0001"},
{"timestamp": "2016-11-11T18:46:53+00:00", "type": "BLE-Connect", "handles": [24, 28]},
{"timestamp": "2016-11-11T18:46:53+00:00", "type": "BLE-Connected", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T18:46:53+00:00", "type": "BLE-Connect", "macAddr": "54D2722149F9"},
{"timestamp": "2016-11-11T18:46:53+00:00", "type": "BLE-Connect", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T18:46:53+00:00", "type": "HTTP-LockState", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T18:46:53+00:00", "type": "WLAN-SocketConnected", "connection": 0},
{"timestamp": "2016-11-11T18:46:36+00:00", "type": "WLAN-SocketDisconnected", "connection": 0},
{"timestamp": "2016-11-11T18:46:36+00:00", "type": "BLE-Disconnected", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T18:46:35+00:00", "type": "BLE-ReceivingMsg", "nukiId": "062149F9", "cmdId": "000C"},
{"timestamp": "2016-11-11T18:46:34+00:00", "type": "BLE-SendingMsg", "nukiId": "062149F9", "cmdId": "0001"},
{"timestamp": "2016-11-11T18:46:34+00:00", "type": "BLE-Connect", "handles": [24, 28]},
{"timestamp": "2016-11-11T18:46:34+00:00", "type": "BLE-Connected", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T18:46:33+00:00", "type": "BLE-Connect", "macAddr": "54D2722149F9"},
{"timestamp": "2016-11-11T18:46:33+00:00", "type": "BLE-Connect", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T18:46:33+00:00", "type": "HTTP-LockState", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T18:46:33+00:00", "type": "WLAN-SocketConnected", "connection": 0},
{"timestamp": "2016-11-11T18:46:27+00:00", "type": "WLAN-SocketDisconnected", "connection": 0},
{"timestamp": "2016-11-11T18:46:13+00:00", "type": "HTTP-List"},
{"timestamp": "2016-11-11T18:46:13+00:00", "type": "WLAN-SocketConnected", "connection": 0},
{"timestamp": "2016-11-11T18:45:52+00:00", "type": "WLAN-SocketDisconnected", "connection": 0},
{"timestamp": "2016-11-11T18:45:52+00:00", "type": "BLE-Disconnected", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T18:45:51+00:00", "type": "BLE-ReceivingMsg", "nukiId": "062149F9", "cmdId": "000C"},
{"timestamp": "2016-11-11T18:45:50+00:00", "type": "BLE-SendingMsg", "nukiId": "062149F9", "cmdId": "0001"},
{"timestamp": "2016-11-11T18:45:50+00:00", "type": "BLE-Connect", "handles": [24, 28]},
{"timestamp": "2016-11-11T18:45:50+00:00", "type": "BLE-Connected", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T18:45:50+00:00", "type": "BLE-Connect", "macAddr": "54D2722149F9"},
{"timestamp": "2016-11-11T18:45:50+00:00", "type": "BLE-Connect", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T18:45:50+00:00", "type": "HTTP-LockState", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T18:45:50+00:00", "type": "WLAN-SocketConnected", "connection": 0},
{"timestamp": "2016-11-11T18:45:33+00:00", "type": "WLAN-SocketDisconnected", "connection": 0},
{"timestamp": "2016-11-11T18:45:33+00:00", "type": "BLE-Disconnected", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T18:45:31+00:00", "type": "BLE-ReceivingMsg", "nukiId": "062149F9", "cmdId": "000C"},
{"timestamp": "2016-11-11T18:45:30+00:00", "type": "BLE-SendingMsg", "nukiId": "062149F9", "cmdId": "0001"},
{"timestamp": "2016-11-11T18:45:30+00:00", "type": "BLE-Connect", "handles": [24, 28]},
{"timestamp": "2016-11-11T18:45:30+00:00", "type": "BLE-Connected", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T18:45:30+00:00", "type": "BLE-Connect", "macAddr": "54D2722149F9"},
{"timestamp": "2016-11-11T18:45:30+00:00", "type": "BLE-Connect", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T18:45:30+00:00", "type": "HTTP-LockState", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T18:45:30+00:00", "type": "WLAN-SocketConnected", "connection": 0},
{"timestamp": "2016-11-11T18:45:20+00:00", "type": "WLAN-SocketDisconnected", "connection": 0},
{"timestamp": "2016-11-11T18:45:10+00:00", "type": "HTTP-List"},
{"timestamp": "2016-11-11T18:45:10+00:00", "type": "WLAN-SocketConnected", "connection": 0},
{"timestamp": "2016-11-11T18:44:52+00:00", "type": "WLAN-SocketDisconnected", "connection": 0},
{"timestamp": "2016-11-11T18:44:52+00:00", "type": "BLE-Disconnected", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T18:44:51+00:00", "type": "BLE-ReceivingMsg", "nukiId": "062149F9", "cmdId": "000C"},
{"timestamp": "2016-11-11T18:44:50+00:00", "type": "BLE-SendingMsg", "nukiId": "062149F9", "cmdId": "0001"},
{"timestamp": "2016-11-11T18:44:50+00:00", "type": "BLE-Connect", "handles": [24, 28]},
{"timestamp": "2016-11-11T18:44:50+00:00", "type": "BLE-Connected", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T18:44:50+00:00", "type": "BLE-Connect", "macAddr": "54D2722149F9"},
{"timestamp": "2016-11-11T18:44:50+00:00", "type": "BLE-Connect", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T18:44:50+00:00", "type": "HTTP-LockState", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T18:44:50+00:00", "type": "WLAN-SocketConnected", "connection": 0},
{"timestamp": "2016-11-11T18:44:32+00:00", "type": "WLAN-SocketDisconnected", "connection": 0},
{"timestamp": "2016-11-11T18:44:32+00:00", "type": "BLE-Disconnected", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T18:44:32+00:00", "type": "BLE-ReceivingMsg", "nukiId": "062149F9", "cmdId": "000C"},
{"timestamp": "2016-11-11T18:44:31+00:00", "type": "BLE-SendingMsg", "nukiId": "062149F9", "cmdId": "0001"},
{"timestamp": "2016-11-11T18:44:31+00:00", "type": "BLE-Connect", "handles": [24, 28]},
{"timestamp": "2016-11-11T18:44:31+00:00", "type": "BLE-Connected", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T18:44:30+00:00", "type": "BLE-Connect", "macAddr": "54D2722149F9"},
{"timestamp": "2016-11-11T18:44:30+00:00", "type": "BLE-Connect", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T18:44:30+00:00", "type": "HTTP-LockState", "nukiId": "062149F9"},
{"timestamp": "2016-11-11T18:44:30+00:00", "type": "WLAN-SocketConnected", "connection": 0},
{"timestamp": "2016-11-11T18:44:21+00:00", "type": "WLAN-SocketDisconnected", "connection": 0},
{"timestamp": "2016-11-11T18:44:07+00:00", "type": "HTTP-List"},
{"timestamp": "2016-11-11T18:44:07+00:00", "type": "WLAN-SocketConnected", "connection": 0},
{"timestamp": "2016-11-11T18:43:52+00:00", "type": "WLAN-SocketDisconnected", "connection": 0}
]

Ich schreib mal Nuki an was die dazu meinen und ob das normal ist dass die Bridge alle halbe Minute die Verbindung zur Bridge und zum Router beendet.

Cobra · 11 November 2016, 20:24:02

Da mir so ein Log grad bekannt vorgekommen ist hab ich mal kurz hier den Thread durchgeschaut und hab folgendes gefunden:
https://forum.fhem.de/index.php/topic,55756.msg508412.html#msg508412

Genau die gleichen Disconnects wie ich. Daher die bitte an jemand der noch eine Hardwarebridge hat. Könntet Ihr mal nachschauen ob bei euch die gleichen Disconnects im Log auftauchen?

CoolTux · 13 November 2016, 10:46:22

Von Nuki selbst gibt es leider noch nichts neues. Weder im Forum noch per Mail.
Da es anscheinend in der Tat an Nuki und der Bridgefirmware liegt habe ich die Timerfunktion also der automatische Request wieder eingebaut.
Die neuste Version als Devel gibt es im Git. Der Link ist auf der ersten Seite.

Aktuell im Devel ist Version 0.3.15

Cobra · 14 November 2016, 16:21:48

Gerade hab ich die Rückmeldung von Nuki bekommen wegen den WLAN-Abbrüchen:

ZitatDanke für die Info.

Wir haben eine Beta Version der Bridge verfügbar, welche das Problem beheben sollte.

Wenn Sie uns ein Foto der ID der Bridge senden, können wir die Firmware für Sie gerne freischalten.

Bin mal gespannt ob es dadurch besser wird. Werde berichten sobald ich die Beta drauf habe

Gruß Cobra

CoolTux · 14 November 2016, 16:36:58

Hatte heute auch ein kurzes Gespräch. Die neue Beta soll wohl unser Timeout und empty response lösen, so habe ich den Kollegen auf jeden Fall verstanden.

Grüße

CoolTux · 16 November 2016, 11:53:53

So Ihr Lieben,

Es gibt Neuigkeiten von Nuki. Uns wurden da einige Empfehlungen gegeben worauf hin ich die Modulfamilie entsprechend hin geändert habe.
Wer möchte kann, unabhängig seiner Firmwareversion, bitte einmal testen.

Neuste Develversion gibt es hier

Was genau passiert. Wenn Ihr die Bridge an legt, werden automatisch alle in der Bridge gefundenen Smartlocks als neue Devices angelegt.
Und das war es auch schon, ERSTMAL.

Schön Wäre wenn diejenigen welche Testen wollen, ihre alten Devices alle löschen und ein neustart machen.
Danach ein define der Bridge und schauen ob in der Bridge die Readings für die Smartlocks auftauchen, danach schauen ob die Smartlockdevices angelegt wurden.

Als nächstes kann ein set BridgeDevice info gemacht werden, damit werden weitere Readings in das Bridgedevice geschrieben. Wenn das geklappt hat macht Ihr bitte bei Eurem SmartlockDevices ein set statusRequest. Immer schön alles nach ein ander. Klappt das dann, gebt mir bitte Bescheid und ich kann dann mal versuchen weiter zu machen.

Grüße

Cobra · 16 November 2016, 17:28:17

Habe Bridge und Lock in FHEM gelöscht, die neue Develversion drauf gemacht, FHEM neu gestartet und die Bridge neu angelegt.
Leider wird kein SmartLock danach gefunden, auch nicht über autocreate

Hier mal der Auszug aus dem LOG:

Code Auswählen

2016.11.16 17:21:30 4: NUKIBridge (NukiBridge) - error while requesting: read from http://192.168.178.56:8080 timed out
2016.11.16 17:21:30 3: NUKIBridge (NukiBridge) - httpheader: 
2016.11.16 17:21:30 3: NUKIBridge (NukiBridge) - PATH: /list?token=xxxxxx
2016.11.16 17:21:30 3: NUKIBridge (NukiBridge) - Error: read from http://192.168.178.56:8080 timed out
2016.11.16 17:21:30 3: NUKIBridge (NukiBridge) - Param Code: 
2016.11.16 17:21:30 3: NUKIBridge (NukiBridge) - Param Alive: 
2016.11.16 17:21:25 4: NUKIBridge (NukiBridge) - error while requesting: http://192.168.178.56:8080/list?token=xxxxxx: empty answer received
2016.11.16 17:21:25 3: NUKIBridge (NukiBridge) - httpheader: 
2016.11.16 17:21:25 3: NUKIBridge (NukiBridge) - PATH: /list?token=xxxxxx
2016.11.16 17:21:25 3: NUKIBridge (NukiBridge) - Error: http://192.168.178.56:8080/list?token=xxxxxx: empty answer received
2016.11.16 17:21:25 3: NUKIBridge (NukiBridge) - Param Code: 
2016.11.16 17:21:25 3: NUKIBridge (NukiBridge) - Param Alive: 
2016.11.16 17:21:25 4: NUKIBridge (NukiBridge) - Send HTTP POST with URL http://192.168.178.56:8080/list?token=xxxxxx
2016.11.16 17:21:21 3: NUKIBridge (NukiBridge) - Kurz vor der Bedingung nach decode_json ARRAY
2016.11.16 17:21:21 3: NUKIDevice (NukiBridge) - empty answer received for http://192.168.178.56:8080/log?token=xxxxxx
2016.11.16 17:21:00 4: NUKIBridge (NukiBridge) - Send HTTP POST with URL http://192.168.178.56:8080/list?token=xxxxxx
2016.11.16 17:20:57 4: NUKIBridge (NukiBridge) - error while requesting: read from http://192.168.178.56:8080 timed out
2016.11.16 17:20:57 3: NUKIBridge (NukiBridge) - httpheader: 
2016.11.16 17:20:57 3: NUKIBridge (NukiBridge) - PATH: /list?token=xxxxxx
2016.11.16 17:20:57 3: NUKIBridge (NukiBridge) - Error: read from http://192.168.178.56:8080 timed out
2016.11.16 17:20:57 3: NUKIBridge (NukiBridge) - Param Code: 
2016.11.16 17:20:57 3: NUKIBridge (NukiBridge) - Param Alive: 
2016.11.16 17:20:27 4: NUKIBridge (NukiBridge) - Send HTTP POST with URL http://192.168.178.56:8080/list?token=xxxxxx
2016.11.16 17:20:19 4: NUKIBridge (NukiBridge) - error while requesting: read from http://192.168.178.56:8080 timed out
2016.11.16 17:20:19 3: NUKIBridge (NukiBridge) - httpheader: 
2016.11.16 17:20:19 1: PERL WARNING: Use of uninitialized value in concatenation (.) or string at ./FHEM/73_NUKIBridge.pm line 354.
2016.11.16 17:20:19 3: NUKIBridge (NukiBridge) - PATH: /list?token=xxxxxx
2016.11.16 17:20:19 3: NUKIBridge (NukiBridge) - Error: read from http://192.168.178.56:8080 timed out
2016.11.16 17:20:19 3: NUKIBridge (NukiBridge) - Param Code: 
2016.11.16 17:20:19 1: PERL WARNING: Use of uninitialized value in concatenation (.) or string at ./FHEM/73_NUKIBridge.pm line 351.
2016.11.16 17:20:19 3: NUKIBridge (NukiBridge) - Param Alive: 
2016.11.16 17:20:19 1: PERL WARNING: Use of uninitialized value in concatenation (.) or string at ./FHEM/73_NUKIBridge.pm line 350.
2016.11.16 17:19:48 3: NUKIBridge (NukiBridge) - defined with host 192.168.178.56 on port 8080, Token xxxxxx

Und die Readings:

Code Auswählen

Readings
lastError
	
read from http://192.168.178.56:8080 timed out
	
2016-11-16 17:22:52
state
	
Initialized
	
2016-11-16 17:22:07

set Device info bringt im Log:

Code Auswählen

Content-Length: 328
Content-Type: application/json;charset=utf-8
Connection: Close
2016.11.16 17:32:01 3: NUKIBridge (NukiBridge) - httpheader: HTTP/1.1 200 OK
2016.11.16 17:32:01 3: NUKIBridge (NukiBridge) - PATH: /info?token=xxxxxx
2016.11.16 17:32:01 3: NUKIBridge (NukiBridge) - Error: 
2016.11.16 17:32:01 3: NUKIBridge (NukiBridge) - Param Code: 200
2016.11.16 17:32:01 3: NUKIBridge (NukiBridge) - Param Alive: 
2016.11.16 17:32:01 4: NUKIBridge (NukiBridge) - Send HTTP POST with URL http://192.168.178.56:8080/info?token=xxxxxx
2016.11.16 17:30:23 4: NUKIBridge (NukiBridge) - error while requesting: read from http://192.168.178.56:8080 timed out
2016.11.16 17:30:23 3: NUKIBridge (NukiBridge) - httpheader: 
2016.11.16 17:30:23 3: NUKIBridge (NukiBridge) - PATH: /list?token=xxxxxx
2016.11.16 17:30:23 3: NUKIBridge (NukiBridge) - Error: read from http://192.168.178.56:8080 timed out
2016.11.16 17:30:23 3: NUKIBridge (NukiBridge) - Param Code: 
2016.11.16 17:30:23 3: NUKIBridge (NukiBridge) - Param Alive: 
2016.11.16 17:29:52 4: NUKIBridge (NukiBridge) - Send HTTP POST with URL http://192.168.178.56:8080/list?token=xxxxxx

Gruß Cobra

Edit: Kurz nach dem Info-Befehl sieht es jetzt so aus:

Code Auswählen

Readings: 
     2016-11-16 17:32:01   bridgeType      Hardware 
     2016-11-16 17:32:01   currentTime     2016-11-16T16:32:02+00:00 
     2016-11-16 17:32:01   hardwareId      95991041 
     2016-11-16 17:35:11   lastError       read from http://192.168.178.56:8080 timed out 
     2016-11-16 17:32:01   serverConnected 1 
     2016-11-16 17:32:01   serverId        1337010944 
     2016-11-16 17:22:07   state           Initialized 
     2016-11-16 17:32:01   uptime          38297

CoolTux · 16 November 2016, 17:38:59

Ok Cobra, vielen Dank fürs Testen. Jetzt fehlt noch einer der die neue Beta Firmware hat. Hoffe das es da ok ist denn sonst weiß ich auch nicht weiter. Das Teil macht jetzt genau nur ein einziges Mal einen Aufruf mit list um die Smartlocks an zulegen und danach nie wieder. Bin ratlos. Er hat sogar ein 30s Timeout bekommen, das sollte selbst die schwächste Bridge schaffen in der Zeit zu Antworten.

Cobra · 16 November 2016, 17:53:29

Ok, komisch. Mit der normalen Version legt er mir jetzt auch kein SmartLock mehr an, hm...