Plantage à nouveau de la box Ikea

nebz · Novembre 1, 2019, 7:54

Bonjour @Loic,

depuis quelques semaines, j’ai de nouveau des plantages journaliers de la box (qui ne se sont plus présentés au début du remake du plugin).

difficile d’estimer à quel moment c’est arrivé car j’ai un peu décroché quand j’ai vu que c’était fonctionnel, je dirais plus ou moins au moment ou tu es passé du package.json à l’installation manuelle des modules.

voici mon retour dans les logs :


[2019-11-01 19:15:24][DEBUG] : Send data to jeedom : {"devices":{"65555":{"id":65555,"name":"Plafond Cafe","firmwareVersion":"1.2.221","model":"TRADFRI bulb GU10 WS 400lm","alive":true,"type":"light","color":"f1e0b5","onOff":false,"dimmer":79.9,"colorTemperature":58.8}}}
[2019-11-01 20:15:24][DEBUG] : Received message : {"devices":{"65555":{"id":65555,"name":"Plafond Cafe","firmwareVersion":"1.2.221","model":"TRADFRI bulb GU10 WS 400lm","alive":true,"type":"light","color":"f1e0b5","onOff":false,"dimmer":79.9,"colorTemperature":58.8}}}
[2019-11-01 19:15:29][DEBUG] : Send data to jeedom : {"devices":{"65556":{"id":65556,"name":"Plafond Taque","firmwareVersion":"1.2.221","model":"TRADFRI bulb GU10 WS 400lm","alive":true,"type":"light","color":"f1e0b5","onOff":false,"dimmer":79.9,"colorTemperature":58.8}}}
[2019-11-01 20:15:29][DEBUG] : Received message : {"devices":{"65556":{"id":65556,"name":"Plafond Taque","firmwareVersion":"1.2.221","model":"TRADFRI bulb GU10 WS 400lm","alive":true,"type":"light","color":"f1e0b5","onOff":false,"dimmer":79.9,"colorTemperature":58.8}}}
[2019-11-01 19:15:40][DEBUG] : Send data to jeedom : {"devices":{"65538":{"id":65538,"name":"Pres de la fenetre","firmwareVersion":"1.2.217","model":"TRADFRI bulb E27 WS opal 980lm","alive":true,"type":"light","color":"f1e0b5","onOff":false,"dimmer":79.9,"colorTemperature":57.4}}}
[2019-11-01 20:15:40][DEBUG] : Received message : {"devices":{"65538":{"id":65538,"name":"Pres de la fenetre","firmwareVersion":"1.2.217","model":"TRADFRI bulb E27 WS opal 980lm","alive":true,"type":"light","color":"f1e0b5","onOff":false,"dimmer":79.9,"colorTemperature":57.4}}}
[2019-11-01 19:16:24][DEBUG] : Send data to jeedom : {"devices":{"65541":{"id":65541,"name":"Triple Haut","firmwareVersion":"1.2.221","model":"TRADFRI bulb E14 WS opal 400lm","alive":true,"type":"light","color":"f1e0b5","onOff":false,"dimmer":79.9,"colorTemperature":58.8}}}
[2019-11-01 20:16:24][DEBUG] : Received message : {"devices":{"65541":{"id":65541,"name":"Triple Haut","firmwareVersion":"1.2.221","model":"TRADFRI bulb E14 WS opal 400lm","alive":true,"type":"light","color":"f1e0b5","onOff":false,"dimmer":79.9,"colorTemperature":58.8}}}
[2019-11-01 19:26:29][DEBUG] : Send data to jeedom : {"devices":{"65549":{"id":65549,"name":"Plafond Cheminee","firmwareVersion":"1.2.214","model":"TRADFRI bulb GU10 W 400lm","alive":true,"type":"light","color":"f1e0b5","onOff":false,"dimmer":100}}}
[2019-11-01 20:26:29][DEBUG] : Received message : {"devices":{"65549":{"id":65549,"name":"Plafond Cheminee","firmwareVersion":"1.2.214","model":"TRADFRI bulb GU10 W 400lm","alive":true,"type":"light","color":"f1e0b5","onOff":false,"dimmer":100}}}
[2019-11-01 19:40:59][DEBUG] : Send data to jeedom : {"devices":{"65545":{"id":65545,"name":"Plafond Buffet","firmwareVersion":"1.2.214","model":"TRADFRI bulb GU10 W 400lm","alive":true,"type":"light","color":"f1e0b5","onOff":true,"dimmer":63}}}
[2019-11-01 20:40:59][DEBUG] : Received message : {"devices":{"65545":{"id":65545,"name":"Plafond Buffet","firmwareVersion":"1.2.214","model":"TRADFRI bulb GU10 W 400lm","alive":true,"type":"light","color":"f1e0b5","onOff":true,"dimmer":63}}}
[2019-11-01 19:41:37][DEBUG] : Device id : 65565
[2019-11-01 19:41:37][DEBUG] : Type id : light
[2019-11-01 19:41:37][DEBUG] : Operation : {"dimmer":"127"}
[2019-11-01 19:41:41][DEBUG] : Device id : 65566
[2019-11-01 19:41:41][DEBUG] : Type id : light
[2019-11-01 19:41:41][DEBUG] : Operation : {"dimmer":"127"}
[2019-11-01 19:41:57][ERROR] : Error on operation : {}
[2019-11-01 20:41:57][ERROR] : Erreur exécution de la commande [Escalier][Plafond Escaliers][Intensité] : {}
[2019-11-01 19:41:57][DEBUG] : Device id : 65565
[2019-11-01 19:41:57][DEBUG] : Type id : light
[2019-11-01 19:41:57][DEBUG] : Operation : {"onOff":true}
[2019-11-01 19:42:11][ERROR] : Error on operation : {}
[2019-11-01 20:42:11][ERROR] : Erreur exécution de la commande [Palier][Plafond Palier][Intensité] : {}
[2019-11-01 19:42:11][DEBUG] : Device id : 65566
[2019-11-01 19:42:11][DEBUG] : Type id : light
[2019-11-01 19:42:11][DEBUG] : Operation : {"onOff":true}
(node:18924) UnhandledPromiseRejectionWarning: Error: The network stack was reset. Pending promises will not be fulfilled.
at TradfriClient.<anonymous> (/var/www/html/plugins/ikealight/resources/ikealightd/node_modules/node-tradfri-client/build/tradfri-client.js:921:40)
at Generator.throw (<anonymous>)
at rejected (/var/www/html/plugins/ikealight/resources/ikealightd/node_modules/node-tradfri-client/build/tradfri-client.js:6:65)
(node:18924) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 21)
(node:18924) UnhandledPromiseRejectionWarning: Error: The network stack was reset. Pending promises will not be fulfilled.
at TradfriClient.<anonymous> (/var/www/html/plugins/ikealight/resources/ikealightd/node_modules/node-tradfri-client/build/tradfri-client.js:921:40)
at Generator.throw (<anonymous>)
at rejected (/var/www/html/plugins/ikealight/resources/ikealightd/node_modules/node-tradfri-client/build/tradfri-client.js:6:65)
(node:18924) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 22)

après j’ai redémarré la passerelle et c’est revenu (gros message avec toutes les lampes)

je ne le signale que maintenant car je n’ai pas pu capturer les logs exact du moment ou ca buggait avant aujourd’hui (ici c’est à 19:41:37 (ou 20:41:37 si c’est le demon ou jeedom))

je ne pense pas que ca te servira car ce n’est que la conséquence du plantage de la box… et aucun message probant juste avant… mais tu es au courant

Nebz

Loic · Novembre 1, 2019, 8:04

Salut,
Malheureusement oui la je vais pas pouvoir en deduire grand chose, tu as des plantages tous les jours ou juste un ?

nebz · Novembre 1, 2019, 11:54

presque tous les jours.

quelque chose a changé dans la fréquence de polling sur la box ou que sais-je par rapport au début de ta reprise du plugin ?

Loic · Novembre 2, 2019, 9:12

Non rien a part la correction pour l’installation des dépendances j’ai touché a rien surtout que j’ai pas d’option de fréquence de polling… Peut être une mise a jour côté ikea

drs · Novembre 2, 2019, 3:21

Bonjour

J’ai le même souci avec un plantage tous les jours, obligeant à redémarrer la box. Lors du plantage, j’ai ce message:

(node:2621) UnhandledPromiseRejectionWarning: Error: Could not establish a secure connection in time. Pending promises will not be fulfilled.
at TradfriClient.<anonymous> (/var/www/html/plugins/ikealight/resources/ikealightd/node_modules/node-tradfri-client/build/tradfri-client.js:925:40)
at Generator.throw (<anonymous>)
at rejected (/var/www/html/plugins/ikealight/resources/ikealightd/node_modules/node-tradfri-client/build/tradfri-client.js:6:65)
at <anonymous>
at process._tickCallback (internal/process/next_tick.js:189:7)
(node:2621) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 39)
[2019-11-01 21:30:54][ERROR] : Erreur exécution de la commande [Salon-Cuisine-Chambre][Panneau Cuis 65553][Allumer] : Echec de la requête http : http://127.0.0.1:55025/device/operation?id=65553&type=light&operation=%7B%22onOff%22%3Atrue%7D&apikey=H2aO5iCFwxetyhEmR9VuXVuHOkETgFxu Curl error : Empty reply from server

Idem, un peu difficile de savoir précisément quand c’est arrivé, mais c’est journalier. Lors du plantage, la gateway répond bien au ping depuis le LAN, mais elle n’est vue ni par Jeedom ni par l’appli Ikea.
Le redémarrage résoud le problème, mais idem le lendemain.

Je suis en Jeedom 3.3.35 (mais le problème était identique en 3.3.33). La version du plugin est 2019-10-17 04:35:36. A tout hasard, je viens de réinstaller les dépendances.

nebz · Novembre 2, 2019, 5:52

Tu as combien de périphériques ?

drs · Novembre 3, 2019, 10:39

Bonjour

Hier soir à nouveau le même problème, malgré la réinstallation des dépendances.
J’ai comme périphériques :

3 panneaux
2 prises
1 ampoule
Donc au total 6, avec leurs interrupteurs chacun.

Loic · Novembre 3, 2019, 11:05

Ca fait pas enorme mais la je vois pas ce que je peux y faire malheureusement pour moi c’est un soucis coté passerelle ikea. Je suis quasi sur que si tu laisse l’application active pendant 1 ou 2 jours ca fera pareils.

Edit : demain yaura une nouvelle version, ca corrigera pas le soucis mais ca donnera peut etre plus de details mais je doute vraiment de pouvoir corriger le probleme

drs · Novembre 3, 2019, 12:48

Bah non c’est pas beaucoup.
Tu as surement raison, cela vient peut être de la passerelle.
Je ferais la maj demain du plugin pour voir si ca change. Sinon est ce qu’il est possible avec jeedom d’envoyer à la passerelle un ordre de redémarrage?

nebz · Novembre 3, 2019, 2:14

Via une prise connectée

drs · Novembre 4, 2019, 3:24

Certes, mais je n’en ai plus de dispo, à part une prise…Ikea

Sinon, question: je suis actuellement sur la version beta. Faut-il que j’installe la stable (qui semble être de la même date)?
Si j’installe la stable, faut-il tout refaire ou bien les équipements seront toujours là?

Merci

nebz · Novembre 4, 2019, 3:57

J’ai la stable et le problème est le même.

Mais oui pour l’instant Pour ce plug-in aucun problème pour passer de stable à bêta Et inversement , rien à recréer

drs · Novembre 5, 2019, 4:20

Bonjour

Toujours le même problème. Cependant, j’ai trouvé la commande pour rebooter la gateway via le réseau.
Pour cela, il faut:

Passer le plugin en debug et le relancer
Dans les logs, récupérer la ligne

Connect to gateway with : {"identity":"XXXXXXXXXX","psk":"YYYYYYYYYY"}

Créer un script action, avec cette commande:

coap-client -m post -u "XXXXXXXXXX" -k "YYYYYYYYYY" "coaps://IP_GATEWAY:5684/15011/9030"

En l’état, avec donc le plugin fonctionnel, la gateway reboote.
J’essaierais la prochaine fois que la gateway plante (car elle répond toujours au ping).

A suivre.

PS: pour info, toutes les commandes coap sont ici: https://github.com/glenndehaan/ikea-tradfri-coap-docs

Loic · Novembre 5, 2019, 4:21

Aurais tu la log du demon en debug ? Si oui il est peut etre possible que jeedom reboot de lui meme la gateway en cas de soucis

drs · Novembre 5, 2019, 4:22

Non, pas en debug. Je viens de le mettre en debug pour tester ma solution de reboot, je vais le laisser comme ça pour récupérer les logs.

drs · Novembre 6, 2019, 5:23

Bonjour

Voilà, encore planté ce soir. J’ai la nette impression que ça plante toutes les 24h.

Voici le log en debug de la mise en route jusqu’au plantage: http://freeline.free.fr/Media/jeedom/ikealight.txt (je le mets en lien car pas possible de joindre un fichier txt, et c’est un peu long à mettre en code).

A noter que ma solution de reboot ne fonctionne pas, car si la gateway est joignable en ip, elle ne l’est plus du tout par coap-client. Donc obligation de faire un off/on sur la gateway.

nebz · Novembre 6, 2019, 5:27

C’est malheureusement ce que je me disais…

Loic · Novembre 6, 2019, 5:30

A mince et la vu l’erreur c’est la gateway qui répond pas malheureusement jeedom pourra pas y faire grand chose

drs · Novembre 6, 2019, 6:18

Effectivement, c’est la gateway qui ne répond plus (sauf au niveau réseau, elle répond toujours au ping).
Alors qu’est ce qui pourrait causer ce dysfonctionnement, sachant qu’il est peu probable que cela vienne de mon installation, vu que je ne suis pas le seul…

des changements survenus dans coap-client?
des changements dans le plugin suite aux dernières mises à jour?
des changements sur la gateway (sachant qu’il n’y a pas eu de maj ces derniers temps)?
des changements au niveau de la connexion jeedom/gateway?

Je n’en sais rien, c’est juste des idées que je lance, mais je pense qu’il faudrait pouvoir investiguer un peu plus.

A ta dispo si tu as besoin pour des tests.

Loic · Novembre 6, 2019, 6:27

La cause est très simple a mon avis, jeedom requête en permanence la gateway pour recuperer des informations, ya un memory leak dans le code de la gateway au bout de X demandes elle plante.

Ya rien a y faire si ce n’est attendre que ikea corrige

Les seules tests que je ferais (mais c’est plus pour prouver ma théorie) :

une tablette avec écran toujours allumé et l’application Ikea lancé en ayant désactivé le plugin côté jeedom et avec un téléphone tester de temps en temps des actions et voir si la tablette de met bien a jour
supprimer des équipements de la gateway et voir si ça réduit les plantage