Le démon se coupe tout seul

Bonjour,

Je suis sur un nuc avec une VM sur Débian 9
Jeedom en V4.0.52
Jeedore dernière version

Par moment je constate que le démon est coupé.
Il se relance ensuite automatiquement grace à l’option dans la config du plugin, mais je ne comprend pas pourquoi ça arrive.

J’ai par contre une piste, à chaque fois c’est arrivé quand j’ai cliqué un peu trop rapidement sur mon bouton xiaomi aqara qui control l’allumage de la lumière.

les logs du démon me disent que le démon est stopé.

J’ai passé mes logs en debug, mais à chaque relaunch du démon, les logs se vident.
Comment vous donner + d’infos pour résoudre le souci ?
J’ai désactiver le redémarrage auto pour le prochain plantage au cas ou…

Merci

Salut

???

as tu mis un heartbeat ?

non, la gestion automatique dans la config du plugin.
ça ne sert pas à ça ?

Hello,

Es tu bien en type de connection Local ? Sais tu grosso-modo la fréquence ? 1 fois par jour, 1 fois par semaine ?
Je ne vois pas prquoi un autre plugin empièterai sur JeeDore… bug jeedom ??? étrange…

Pour que le plugin ne supprime pas le log au démarrage, tu peux supprimer dans le fichier jeedore.class.php la ligne :

log::remove(‹ jeedoredaemon ›);

tu n’as rien dans le log jeedore ?

Eli

oui je suis bien en local

je n’utilise pas trop la domotique pour l’instant, c’est une fresh install, mais ça m’est arrivé les 2 dernier jours depuis l’installation de deconz, et donc c’est depuis cette date que j’ai commencé à utiliser jeedore réellement

J’ai bien supprimé la ligne, on verra ce que ça dit la prochaine fois, merci.

le log jeedore ne remonte pas plus loin qu’aujourd’hui à 19h, donc non, rien :frowning:

J4ai relancé une installe des dépendences et relancé le démon du coup, maintenant on va attendre que j’ai des logs à te fournir :slight_smile: .

Hello,

OK wait & see.

Concernant les dépendances cela n’a aucun intérêt de les réinstaller si le daemon se lance. Ce n’est que le framework dotnet, il n’y a aucun code jeedore dans les dépendances

Eli

J4ai donc fait un peu mumuse avec le bouton ce matin, et pouf, démon NOK.

Logs du démon :

04/29/2020 11:00:02 - Sending command 1588150801418 to DeltaDore....
04/29/2020 11:00:21 - Executing command to device : 'Rezolv.JeeDore.Server.JeeDore.Request.LevelCmd'...
04/29/2020 11:00:21 - Sending command 1588150821382 to DeltaDore....
04/29/2020 11:00:21 - Command 1588150821382 executed!
04/29/2020 11:00:23 - Sending command 1588150822919 to DeltaDore....
04/29/2020 11:00:24 - Executing command to device : 'Rezolv.JeeDore.Server.JeeDore.Request.LevelCmd'...
04/29/2020 11:00:24 - Sending command 1588150824420 to DeltaDore....
04/29/2020 11:00:24 - Command 1588150824420 executed!
04/29/2020 11:00:26 - Executing command to device : 'Rezolv.JeeDore.Server.JeeDore.Request.LevelCmd'...
04/29/2020 11:00:26 - Sending command 1588150826605 to DeltaDore....
04/29/2020 11:00:26 - Command 1588150826605 executed!
04/29/2020 11:00:29 - Executing command to device : 'Rezolv.JeeDore.Server.JeeDore.Request.LevelCmd'...
04/29/2020 11:00:29 - Sending command 1588150829534 to DeltaDore....
04/29/2020 11:00:29 - Command 1588150829534 executed!
04/29/2020 11:00:31 - Executing command to device : 'Rezolv.JeeDore.Server.JeeDore.Request.LevelCmd'...
04/29/2020 11:00:31 - Sending command 1588150831570 to DeltaDore....
04/29/2020 11:00:31 - Command 1588150831570 executed!
04/29/2020 11:00:31 - Executing command to device : 'Rezolv.JeeDore.Server.JeeDore.Request.LevelCmd'...
04/29/2020 11:00:31 - Stoping timer Info
04/29/2020 11:00:31 - Stoping timer energyInstant ELEC_A
04/29/2020 11:00:31 - Impossible to launch JeeDore Server
04/29/2020 11:00:31 - An item with the same key has already been added. Key: 1588150831570
04/29/2020 11:00:31 - Impossible to launch Jeedore daemon...
04/29/2020 11:00:31 - An item with the same key has already been added. Key: 1588150831570
04/29/2020 11:00:31 - Daemon has been stopped...

Logs Jeedore :

[2020-04-29 11:00:21][DEBUG] : Sending to JeeDore Daemon : setLevelCmdToggle
[2020-04-29 11:00:23][DEBUG] : Sending to JeeDore Daemon : setLevelCmdToggle
[2020-04-29 11:00:26][DEBUG] : Sending to JeeDore Daemon : setLevelCmdToggle
[2020-04-29 11:00:29][DEBUG] : Sending to JeeDore Daemon : setLevelCmdToggle
[2020-04-29 11:00:31][DEBUG] : Sending to JeeDore Daemon : level
[2020-04-29 11:00:31][DEBUG] : Sending to JeeDore Daemon : level
[2020-04-29 11:00:31][DEBUG] : Sending to JeeDore Daemon : level
[2020-04-29 11:00:31][DEBUG] : Sending to JeeDore Daemon : setLevelCmdToggle
[2020-04-29 11:00:31][DEBUG] : Sending to JeeDore Daemon : setLevelCmdToggle
[2020-04-29 11:00:34][DEBUG] : Sending to JeeDore Daemon : setLevelCmdToggle
[2020-04-29 11:00:36][DEBUG] : Sending to JeeDore Daemon : setLevelCmdToggle
[2020-04-29 11:00:38][DEBUG] : Sending to JeeDore Daemon : setLevelCmdToggle
[2020-04-29 11:00:40][DEBUG] : Sending to JeeDore Daemon : setLevelCmdToggle
[2020-04-29 11:00:42][DEBUG] : Sending to JeeDore Daemon : setLevelCmdToggle
[2020-04-29 11:00:44][DEBUG] : Sending to JeeDore Daemon : setLevelCmdToggle
[2020-04-29 11:01:40][DEBUG] : Sending to JeeDore Daemon : setLevelCmdToggle

même chose aujourd’hui après avoir cliqué sur mon bouton xiaomi aqara cntrolé par deconz :

Jeedore démon :

04/30/2020 11:35:07 - Executing command to device : 'Rezolv.JeeDore.Server.JeeDore.Request.LevelCmd'...
04/30/2020 11:35:07 - Sending command 1588239307100 to DeltaDore....
04/30/2020 11:35:07 - Command 1588239307100 executed!
04/30/2020 11:35:10 - Executing command to device : 'Rezolv.JeeDore.Server.JeeDore.Request.LevelCmd'...
04/30/2020 11:35:10 - Sending command 1588239310940 to DeltaDore....
04/30/2020 11:35:10 - Command 1588239310940 executed!
04/30/2020 11:35:12 - Executing command to device : 'Rezolv.JeeDore.Server.JeeDore.Request.LevelCmd'...
04/30/2020 11:35:12 - Sending command 1588239312308 to DeltaDore....
04/30/2020 11:35:12 - Command 1588239312308 executed!
04/30/2020 11:35:32 - Executing command to device : 'Rezolv.JeeDore.Server.JeeDore.Request.LevelCmd'...
04/30/2020 11:35:32 - Sending command 1588239332568 to DeltaDore....
04/30/2020 11:35:32 - Command 1588239332568 executed!
04/30/2020 11:35:33 - Executing command to device : 'Rezolv.JeeDore.Server.JeeDore.Request.LevelCmd'...
04/30/2020 11:35:33 - Sending command 1588239333995 to DeltaDore....
04/30/2020 11:35:33 - Command 1588239333995 executed!
04/30/2020 11:35:33 - Executing command to device : 'Rezolv.JeeDore.Server.JeeDore.Request.LevelCmd'...
04/30/2020 11:35:33 - Stoping timer Info
04/30/2020 11:35:33 - Stoping timer energyInstant ELEC_A
04/30/2020 11:35:33 - Impossible to launch JeeDore Server
04/30/2020 11:35:33 - An item with the same key has already been added. Key: 1588239333995
04/30/2020 11:35:33 - Impossible to launch Jeedore daemon...
04/30/2020 11:35:33 - An item with the same key has already been added. Key: 1588239333995
04/30/2020 11:35:33 - Daemon has been stopped...

Deconz :

[2020-04-30 11:35:06.888][DEBUG] : Received message from gateway 192.168.1.103 : {"e":"changed","id":"5","r":"sensors","state":{"buttonevent":1004,"lastupdated":"2020-04-30T09:35:06"},"t":"event","uniqueid":"00:15:8d:00:01:a5:d0:89-01-0006"}
[2020-04-30 11:35:06.888][DEBUG] : Send to jeedom :  {'00212EFFFF059DFE': {'id': '5', 'state': {'lastupdated': '2020-04-30T09:35:06', 'buttonevent': 1004}, 'uniqueid': '00:15:8d:00:01:a5:d0:89-01-0006', 'r': 'sensors', 'e': 'changed', 't': 'event'}}
[2020-04-30 11:35:06.889][DEBUG] : Starting new HTTP connection (1): 127.0.0.1
[2020-04-30 11:35:06][DEBUG] : {"00212EFFFF059DFE":{"id":"5","state":{"lastupdated":"2020-04-30T09:35:06","buttonevent":1004},"uniqueid":"00:15:8d:00:01:a5:d0:89-01-0006","r":"sensors","e":"changed","t":"event"}}
[2020-04-30 11:35:06.912][DEBUG] : http://127.0.0.1:80 "POST /plugins/deconz/core/php/jeeDeconz.php?apikey=m9IMqfcvvhIZnIvnZE0UrPREy1lqnp5u HTTP/1.1" 200 0
[2020-04-30 11:35:07.077][DEBUG] : Received message from gateway 192.168.1.103 : {"e":"changed","id":"5","r":"sensors","state":{"buttonevent":1002,"lastupdated":"2020-04-30T09:35:07"},"t":"event","uniqueid":"00:15:8d:00:01:a5:d0:89-01-0006"}
[2020-04-30 11:35:07.082][DEBUG] : Send to jeedom :  {'00212EFFFF059DFE': {'id': '5', 'state': {'lastupdated': '2020-04-30T09:35:07', 'buttonevent': 1002}, 'uniqueid': '00:15:8d:00:01:a5:d0:89-01-0006', 'r': 'sensors', 'e': 'changed', 't': 'event'}}
[2020-04-30 11:35:07.083][DEBUG] : Starting new HTTP connection (1): 127.0.0.1
[2020-04-30 11:35:07][DEBUG] : {"00212EFFFF059DFE":{"id":"5","state":{"lastupdated":"2020-04-30T09:35:07","buttonevent":1002},"uniqueid":"00:15:8d:00:01:a5:d0:89-01-0006","r":"sensors","e":"changed","t":"event"}}
[2020-04-30 11:35:07.098][DEBUG] : http://127.0.0.1:80 "POST /plugins/deconz/core/php/jeeDeconz.php?apikey=m9IMqfcvvhIZnIvnZE0UrPREy1lqnp5u HTTP/1.1" 200 0

Aucune idée ? :frowning:

Hello,

Si une idée mais grosse semaine de boulot, assez crevé :wink: je pense que ça ne prendra peu de temps. En tout cas, ton log m’a bien aidé :metal:
Je check ça pdt le week-end :wink:

Eli

génial, merci !

Même problème, si quelqu’un a trouvé une solution

1 « J'aime »

Je ne sais pas si il y a un rapport, mais ça a encore planté.
Cette fois je ne passais pas du tout par deconz, mais par le dashboard de jeedom :

05/22/2020 01:52:44 - Executing command to device : 'Rezolv.JeeDore.Server.JeeDore.Request.Position'...
05/22/2020 01:52:44 - Sending command 1590105164380 to DeltaDore....
05/22/2020 01:52:44 - Command 1590105164380 executed!
05/22/2020 01:52:46 - Executing command to device : 'Rezolv.JeeDore.Server.JeeDore.Request.Position'...
05/22/2020 01:52:46 - Sending command 1590105166145 to DeltaDore....
05/22/2020 01:52:46 - Command 1590105166145 executed!
05/22/2020 01:52:49 - Executing command to device : 'Rezolv.JeeDore.Server.JeeDore.Request.PositionCmd.PositionCmd'...
05/22/2020 01:52:49 - Sending command 1590105169696 to DeltaDore....
05/22/2020 01:52:49 - Command 1590105169696 executed!
05/22/2020 01:53:03 - Executing command to device : 'Rezolv.JeeDore.Server.JeeDore.Request.Position'...
05/22/2020 01:53:03 - Sending command 1590105183010 to DeltaDore....
05/22/2020 01:53:03 - Command 1590105183010 executed!
05/22/2020 01:53:03 - Executing command to device : 'Rezolv.JeeDore.Server.JeeDore.Request.Position'...
05/22/2020 01:53:03 - Stoping timer Info
05/22/2020 01:53:03 - Stoping timer energyInstant ELEC_A
05/22/2020 01:53:03 - Impossible to launch JeeDore Server
05/22/2020 01:53:03 - An item with the same key has already been added. Key: 1590105183010
05/22/2020 01:53:03 - Impossible to launch Jeedore daemon...
05/22/2020 01:53:03 - An item with the same key has already been added. Key: 1590105183010
05/22/2020 01:53:03 - Daemon has been stopped...

Hello,

Je suis intéressé aussi car dans le même cas.

J’ai l’impression que c’est seulement lorsque d’envoi plusieurs commandes en même temps (ex: fermer tous les volets)

Je retrouve ce genre de chose dans les logs Jeedore:

06/16/2020 13:45:52 - Executing command to device : ‹ Rezolv.JeeDore.Server.JeeDore.Request.PositionCmd.PositionCmd ›…
06/16/2020 13:45:52 - Sending command 1592307952607 to DeltaDore…
06/16/2020 13:45:52 - Command 1592307952607 executed!
06/16/2020 13:45:52 - Executing command to device : ‹ Rezolv.JeeDore.Server.JeeDore.Request.PositionCmd.PositionCmd ›…
06/16/2020 13:45:52 - Sending command 1592307952609 to DeltaDore…
06/16/2020 13:45:52 - Command 1592307952609 executed!
06/16/2020 13:45:52 - Executing command to device : ‹ Rezolv.JeeDore.Server.JeeDore.Request.PositionCmd.PositionCmd ›…
06/16/2020 13:45:52 - Sending command 1592307952610 to DeltaDore…
06/16/2020 13:45:52 - Command 1592307952610 executed!
06/16/2020 13:45:52 - Executing command to device : ‹ Rezolv.JeeDore.Server.JeeDore.Request.PositionCmd.PositionCmd ›…
06/16/2020 13:45:52 - Sending command 1592307952611 to DeltaDore…
06/16/2020 13:45:52 - Command 1592307952611 executed!
06/16/2020 13:45:52 - Executing command to device : ‹ Rezolv.JeeDore.Server.JeeDore.Request.PositionCmd.PositionCmd ›…
06/16/2020 13:45:52 - Stoping timer Info
06/16/2020 13:45:52 - Impossible to launch JeeDore Server
06/16/2020 13:45:52 - An item with the same key has already been added. Key: 1592307952611
06/16/2020 13:45:52 - Impossible to launch Jeedore daemon…
06/16/2020 13:45:52 - An item with the same key has already been added. Key: 1592307952611
06/16/2020 13:45:52 - Daemon has been stopped…

J’ai essayé de réinstaller le plugin, vider le cache Jeedom, rien n’y fait.

Je pense que Jeedore retrouve une référence à un équipement mal supprimé de la BDD de Jeedom.

Bonne piste ?

Ma config:

  • Version Jeedom: Stable V4
  • Debian 10.3
  • Arch: X86_64
  • Version Jeedore: 2020-04-19 18:19:54
  • Version Tydom: 1.0
  • Réseau Tydom: local

A dispo s’il faut donner plus d’infos/faire d’autres tests.

Petit up: après avoir essayé quelques bidouilles, j’ai une piste je pense.

J’ai un scénario qui gère l’ouverture/fermeture de mes volets.
Si on lui dit « tous les volets », il ferme mes 7 volets en même temps par une succession de commande « setPositionCmdDown » à chaque volet; tout ça en m^mee temps sur tous les volets.

J’ai d’abord pensé que le Tydom n’aimait pas avoir autant de commandes d’un coup et j’ai essayé de réjouter un timer (sleep 1) entre chaque commande « setPositionCmdDown »

Ça n’a rien changé. Du coup je ne pense pas que ça soit un problème de quantité d’appels simultanés.

Par contre, j’ai essayé de désactiver un à un mes volets et de relancer le scénario à chaque désactivation (d’abord 1 volet, puis 2, puis 3, etc… jusqu’à 7)

Je me suis rendu compte que dés que je désactivais spécifiquement mon volet « Façade 1 » ça marchait.

Je pense que c’est cet équipement qui provoque les erreurs du type:

An item with the same key has already been added

Je n’ai pas trop le temps tout de suite, mais dés que possible je vais essayer de le supprimer de Jeedore et également via l’application Tydom.
Puis je réessaierai et vous tiendrais au courant.

PS: ça serait intéressant de pouvoir retrouve le nom de l’équipement à partir de la clef que Jeedore donne dans ses logs. Une requête SQL à faire certainement. Si quelqu’un a une idée, je suis preneur !
Ca permettrait de bien nettoyer la BDD Jeedom de toute référence à cette entrée obsolète qui semble faire planter Jeedore.

++

Bonjour,
Même problème pour moi. Cela vient de se produire après une migration de ma plateforme sur un environnement Debian 10 sur proxmox depuis un environnement rasp.
J’ai les deux plateformes en parallèle, plugin beta sur les deux, dernière version jeedom sur les 2, les deux en debian 10.
Sur rasp, aucun problème, tout fonctionne. Sur la plateforme x86, systématiquement lorsque je lance une commande de fermeture / ouverture globale des volets ( 7 volets) le démon tombe avec la même erreur que les autres…
Espérons que cela puisse vous aider à trouver le problème.

Hervé

Hello tous,

Je viens de trouver une piste qui porte ses fruits pour moi pour l’instant et qui aidera peut-être:

Dans mon scénario qui ouver/ferme tous mes volets (7 volets) en même temps, j’ai remarqué deux choses:

  • Cela ne se produit que lorsqu’un certain volet est dans la liste à traiter par le scénario (quand je la de-selectionne ça fonctionne)
  • Si dans la liste des volets à traiter, pour tous les volets sauf celui qui pose problème; je coche la case permettant d’exécuter l’action en parallèle des autres (deuxième cache en face de l’action, à coté de la case servant à désactiver l’action), cela fonctionne aussi. Tous mes volets se ferment et s’ouvrent correctement.

En espérant que ça aidera

++

Salut tout le monde,

Bon, faux espoir: j’ai l’impression que ça ne marche pas si bien que ça.

Le démon plante à nouveau quand j’envoie une commande sur plusieurs volets en même temps.

J’ai ce genre de logs dans les logs du démon:

[2020-07-08 02:07:16][ERROR] : Impossible to find command with id : thermicDefect1594166832#1594166832
[2020-07-08 02:07:16][ERROR] : Impossible to find command with id : position1594166832#1594166832
[2020-07-08 02:07:16][ERROR] : Impossible to find command with id : onFavPos1594166832#1594166832
[2020-07-08 02:07:16][ERROR] : Impossible to find command with id : upDefect1594166832#1594166832
[2020-07-08 02:07:16][ERROR] : Impossible to find command with id : downDefect1594166832#1594166832
[2020-07-08 02:07:16][ERROR] : Impossible to find command with id : obstacleDefect1594166832#1594166832
[2020-07-08 02:07:16][ERROR] : Impossible to find command with id : intrusion1594166832#1594166832
[2020-07-08 02:07:16][ERROR] : Impossible to find command with id : battDefect1594166832#1594166832

Si quelqu’un a une idée, je suis preneur.

++

pas de nouvelle du dev à ce sujet ? :frowning: @Eli

Salut @jerome83136
peut être en faisant un scénario sur ton tydom de fermetures de l’ensemble de tes volets et le lancé via jeedom résoudrait provisoirement ton problème .

1 « J'aime »