[Fermé] ZigateEthernet : Reboot périodique du plugin et erreur firmware

[FCJean]

Bonjour à tous,

Tout d'abord les infos "contextuelles"

Code : Tout sélectionner

Version de DomoticZ : 2020.2
Système sur lequel tourne DomoticZ avec le plugin : Debian 10 sur VM VMware (ESX 6.0)
Modèle de ZiGate : V2
Version de ZiGate : Zigate Ethernet
Version du firmware : 3.21
Type de firmware : standard 
Version du plugin : 5.1.015
Branche du plugin : stable5

Maintenant les problèmes (liés ?).
Au démarrage du plugin (ligne 152 du log joint) j'ai cette erreur

Code : Tout sélectionner

2021-12-27 14:36:40.089  Error: (ZigateEth) Firmware 0321 is not yet supported

Mais 2 lignes plus tard ça ne semble pas trop le déranger

Code : Tout sélectionner

2021-12-27 14:36:40.144  Status: (ZigateEth) Plugin with Zigate+, firmware 0321 correctly initialized

Le problème majeur est que le plug-in "reboote" maintenant presque tous les jours depuis que je suis passé sur Zigate Ethernet (sur Zigate WiFi, il n'y avait aucun problème). Le plugin semble détecter tous les jours (voire plusieurs fois par jour) un problème de "Heartbeat" suite visiblement à une non réponse au ping.

Code : Tout sélectionner

2021-12-27 14:35:08.624  (ZigateEth) pingZigate - WARNING: Ping sent but no response yet from Zigate. Status: Sent  - Ping: 5 sec
2021-12-27 14:35:13.598  (ZigateEth) pingZigate - WARNING: Ping sent but no response yet from Zigate. Status: Sent  - Ping: 10 sec
2021-12-27 14:35:18.623  (ZigateEth) pingZigate - WARNING: Ping sent but no response yet from Zigate. Status: Sent  - Ping: 15 sec
2021-12-27 14:35:20.483  HttpLink: sending global variable 202 with value: 11
2021-12-27 14:35:20.485  HttpLink: response 
2021-12-27 14:35:23.597  (ZigateEth) pingZigate - WARNING: Ping sent but no response yet from Zigate. Status: Sent  - Ping: 20 sec
2021-12-27 14:35:28.620  (ZigateEth) pingZigate - WARNING: Ping sent but no response yet from Zigate. Status: Sent  - Ping: 25 sec
2021-12-27 14:35:33.592  (ZigateEth) pingZigate - WARNING: Ping sent but no response yet from Zigate. Status: Sent  - Ping: 30 sec
2021-12-27 14:35:38.616  (ZigateEth) pingZigate - WARNING: Ping sent but no response yet from Zigate. Status: Sent  - Ping: 35 sec
2021-12-27 14:35:43.641  (ZigateEth) pingZigate - WARNING: Ping sent but no response yet from Zigate. Status: Sent  - Ping: 40 sec
2021-12-27 14:35:48.614  (ZigateEth) pingZigate - WARNING: Ping sent but no response yet from Zigate. Status: Sent  - Ping: 45 sec
2021-12-27 14:35:53.653  (ZigateEth) pingZigate - WARNING: Ping sent but no response yet from Zigate. Status: Sent  - Ping: 50 sec
2021-12-27 14:35:58.626  (ZigateEth) pingZigate - WARNING: Ping sent but no response yet from Zigate. Status: Sent  - Ping: 55 sec
2021-12-27 14:36:00.683  HttpLink: sending global variable 42 with value: 15.5
2021-12-27 14:36:00.686  HttpLink: response 
2021-12-27 14:36:03.603  (ZigateEth) pingZigate - WARNING: Ping sent but no response yet from Zigate. Status: Sent  - Ping: 60 sec
2021-12-27 14:36:03.603  Error: (ZigateEth) pingZigate - no Heartbeat with Zigate, try to reConnect
2021-12-27 14:36:03.608  Status: (ZigateEth) Plugin Restart command : http://domoticz:5b836df544514b739293268f91e29e1e@127.0.0.1:8080/json.htm?type=command&param=updatehardware&htype=94&idx=7&name=ZigateEth&address=192.168.0.245&port=9999&serialport=/dev/ttyUSB0&Mode1=V2&Mode2=Wifi&Mode3=False&Mode4=9450&Mode5=&Mode6=2&extra=Zigate&enabled=true&datatimeout=0
2021-12-27 14:36:03.637  Status: (ZigateEth) Stop directive received.
2021-12-27 14:36:03.637  Status: (ZigateEth) Exiting work loop.
2021-12-27 14:36:03.722  (ZigateEth) Connection closed

Bien sur, si jeffectue un ping "manuel" depuis la VM qui héberge Domoticz et le plugin vers la Zigate Ethernet, je n'ai jamais aucun problème de latence

Code : Tout sélectionner

64 bytes from 192.168.0.245: icmp_seq=3 ttl=255 time=0.197 ms

Par ailleurs, j'ai activé dans le "firmware" de la Zigate Ethernet l'option

Code : Tout sélectionner

Enable HeartBeat (send ping to TCP when no trafic)

ce qui visiblement ne change pas grand chose ...
J'ai aussi "disablé" le WiFi de la Zigate Ethernet et tous mes routeurs et répéteurs WiFi sont sur des canaux sans overlap avec le canal 11 Zigbee utilisé ...

J'ai l'impression que le plugin ne reconnait pas correctement la Zigate Ethernet au démarrage (après pas de problème, j'ai 43 devices qui se connectent et sont opérationnels) quand je vois ces lignes :

Code : Tout sélectionner

2021-12-27 14:36:05.537  Status: (ZigateEth) Connection Name: Zigate, Transport: TCP/IP, Address: None:9999
2021-12-27 14:36:05.537  Status: (ZigateEth) Transport mode: V2-Wifi

Pourquoi l'adresse IP de la Zigate (évidemment correctement renseignée) ne remonte t'elle pas ?
Je ne m'inquiète pas trop du Transport mode "Wifi" car je pense que ce sont les mêmes sockets utilisés en WiFi et en Eth ...

Vu que le reboot du plugin est très pénalisant (il faut près de 30 mn pour que tous les devices remontent et bien sûr pendant ce temps là les automatisations ....), il y a t'il un paramètre à positionner quelque part pour éviter le ping, changer sa périodicité ou autre chose pour essayer de comprendre ce qui se passe ?
Merci d'avance (à Pipiche ?) de m'éclairer sur ces points.
Passez tous de bonnes fêtes !

logDemarrage.rar

(6.5 Kio) Téléchargé 117 fois

[Keros]

Merci FCJean pour toutes ces infos précises.

Je peux seulement te donner quelques réponses :

• Firmware 0321 is not yet supported

N'en tiens pas compte : ta version du plugin semble antérieure à celle du firmware, d'où cette info. Mais cela n'empêche pas le plugin de fonctionner.
D'ailleurs, une nouvelle version stable vient de sortir. Ce message ne devrait plus y être

• Délai de 30 minutes

Cela ne devrait pas être pénalisant dans le sens où, en fonctionnement "sans problème" le délai de remonter d'info est le même. Tu dois le voir surtout sur des sondes de températures. Pour ne pas utiliser trop d'énergie, elles n'envoient des infos que toutes les 30 minutes (ou toutes les heures). Alors oui les graphiques d'historique montrent des valeurs changeantes toutes les 5 minutes, mais cela ne signifie pas que DomoticZ reçoit la nouvelle info toutes les 5 minutes.
Il n'y a qu'en cas de grosse variation, que généralement la sonde renvoie une nouvelle valeur avec un délai plus court.

Les boutons, c'est pareil : dès que tu appuies dessus, l'ordre est envoyé. Les prises et lampes, elles sont sur secteur avec fonction de routeur : elles remontent dès la remise en route.

Le reboot est pénalisant (et il faut en trouver la cause), mais une fois relancé, ton système est normalement opérationnel quasiment tout de suite.
Si par contre, tu as une commande qui est bloquée pendant 30 minutes, là, c'est un autre souci.

[FCJean]

Merci Keros pour ta réponse rapide !
Je vais bien sûr installer la dernière version stable du plugin.

Mais il va falloir que j'élucide ce problème de "heartbeat" en corélant tout ce qui se passe sur le réseau au moment où le plugin pense avoir perdu la Zigate ... et cela ne va pas être simple car j'ai 11 autres VMs (OMV, MQTT, InfluxDB, Grafana, HomeBridge - qui pourrait être un suspect vu le peu de fiabilité de certains ce ses plugins, GoogleHome entre autres), sans compter les NodeMCU, Shelly, pompe à chaleur, onduleur solaire, PCs, smartphones et autres tablettes (j'ai 71 IP actives sur mon réseau) ...
Donc avant de faire des mesures Wireshark dans tous les sens, je voulais savoir s'il y avait un paramètre gérant la périodicité du ping (ou même désactiver ce ping temporairement) et quid de l'interaction avec le heartbeat généré par la Zigate Ethernet (qui me semble ne pouvoir être que totalement disjoint car on ne renseigne que l'adresse du routeur réseau dans la Zigate Ethernet ...).

En ce qui concerne le temps de remontée. Il est évident que les capteurs sur pile, ne communiquant que lorsqu'il y a une variation, ne sont en général pas les premiers à remonter (à l'exception d'un capteur de température Konke que j'avais acheté justement pour tester la différence avec les Xiaomi, qui lui remonte toujours en premier !). Ce qui est curieux, c'est que les routeurs, alimentés en continu sur secteur, ne remontent pas forcément en premier loin s'en faut ! J'ai des répéteurs IKEA et des smart switches Tuya (avec neutre, je ne parle pas des sans neutre) qui remontent pratiquement au bout de 30-40 mn, même quand on les sollicite en effectuant des commutations manuelles ... faute au maillage je suppose. Dommage que l'on ne puisse pas spécifier un maillage statique entre routeurs et coordinateur... Je précise que je n'ai bien sûr aucune ampoule connectée qui pourrait jouer le rôle de routeur fantôme et flanquer par terre le maillage quand elle n'est pas allumée.

Donc j'ai pas mal de boulot devant moi pour que le "WAF" de tout cela ne plonge pas de manière rédibitoire. Pour ma femme, si c'est en production, cela doit fonctionner en 24x7 ... et je ne peux pas lui donner tort (c'est pour cela que j'ai des onduleurs pour les serveurs, switchs, box, etc.).

Merci en tout cas à ce super forum.
Je vous tiens au courant si j'arrive à comprendre quelque chose !

[pipiche]

Accèdes tu en paralelle à l'interface de la PiZigate-Ethernet ?
Je pense qu'il faut que vous preniez contact avec le vendeur le la Pi-Zigate ethernet, peut-etre un problème de configuration.

[FCJean]

Hello,
Merci Pipiche.
J'ai fait l'upgrade du plugin (enfin j'avais fait le git pull et l'upgrade s'est fait tout seul lors du reboot de ce matin), j'ai déjà eu 2 reboots du plug-in en moins de 12h ....
Il y a peut-être une piste car il y a eu des signes avant-coureurs, 1 mn avant de rentrer dans la "séquence de ping de la mort"

Code : Tout sélectionner

2021-12-28 15:59:28.997  Error: (ZigateEth) tcpip_read_from_zigate: Connection error while receiving data [Errno 104] Connection reset by peer on <socket.socket fd=36, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=6, laddr=('192.168.0.114', 46258)>
2021-12-28 15:59:28.998  Status: (ZigateEth) ZigateTransport: TCPIP Connection open: <socket.socket fd=38, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=6, laddr=('192.168.0.114', 54930), raddr=('192.168.0.245', 9999)>
2021-12-28 15:59:30.000  (ZigateEth) tcp_re_connect - TCP connection successfuly re-established :-) <socket.socket fd=38, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=6, laddr=('192.168.0.114', 54930), raddr=('192.168.0.245', 9999)>
....
2021-12-28 16:01:40.949  (ZigateEth) pingZigate - WARNING: Ping sent but no response yet from Zigate. Status: Sent  - Ping: 5 sec

Erreur de connexion, connection reset, puis successfully reconnect.
Cette séquence arrive de temps en temps, pas toujours suivi des pings et du reboot ... très bizarre. Bien sûr, toutes les IP sont en statique ...

Lors de ce reboot en particulier j'accédais en effet en parallèle à l'interface de la Zigate-Ethernet (et aussi à l'interface Web du plug-in) pour essayer de monitorer un peu.
Malheureusement, le problème survient aussi lorsque rien n'est connecté.
Je pense que je vais en effet contacter le vendeur, car je ne vois pas quel problème de config il peut y avoir.

Si cela continue, je passerai peut-être Domoticz sur un Raspberry et mettrai la Zigate en PiZigate ... là normalement on ne devrait pas rencontrer de problèmes TCP avec des communications GPIO ... mais bon ce serait quand même une régression je trouve que de passer d'un bipro 32 coeurs, 48 GB de RAM à quelque chose qui boote sur une carte SD ...

Je mets le log du dernier reboot à tout hazard.

[Keros]

un bipro 32 coeurs, 48 GB de RAM

Et dire que je viens de monter Proxmox sur un NUC core I3 avec 8Go de RAM et qu'avec 2 VM, il est déjà plein
Au moins, j'ai découvert Promox

[pipiche]

A ma connaissance, ily a un bug sur la PIZigate Ethernet et il ne faut surtout pas monitorer en paralell. Donc surtout ne pas utiliser le mode console. Et je crois que meme les ping en paralell posent problèmes

[FCJean]

@Keros

Il est clair que ma config pour de la domotique est un peu un overkill ....
Là où cela devient un peu plus utile c'est pour Plex, Open MediaVault et Zoneminder, car même InfluxDB et Grafana ne prennent en pic qu'environ 2% du CPU, alors Domoticz ...
Je pense que je vais segmenter mon réseau (qui n'est pas encore en 10Gb, même si j'ai tiré des cables Cat7 partout) et peut-être mettre une ou plusieurs VM OpenWRT pour filtrer et router tout cela. Si DZ et la Zigate Ethernet sont tout seuls sur un réseau Gigabit ... ils devraient quand même arriver à ne pas se perdre de vue !
Mais comme tu dis l'important dans tout cela est de découvrir de nouveau produits et expérimenter.

@Pipiche

OK merci Pipiche.
Je ne monitore plus ! Mais j'ai eu les mêmes problèmes de reboot alors que je n'étais pas là, je ne m'en suis aperçu qu'en regardant les logs de DZ.

Je peux peut-être aussi cocher : Disable web server when ZiGate is connected dans l'interface de la Zigate comme cela on est sûr, mais cela me parait quand même à usage unique cette commande car comment revenir pour paraméter quelque chose (changement d'adresse IP par exemple) par la suite.

Je suis revenu à 36 devices remontés sur 43 ... et ceux qui restent à remonter sont des routeurs !
Ce qui est fascinant par ailleurs c'est qu'un des smart switchs qui ne remonte pas et qui est en Statut "Left" et Santé "Time out" ... commute bien quand on l'active depuis Domoticz (ou via http/json) ! va comprendre ...

[pipiche]

Ca il faut le laisser sinon tu n'auras plus accès au WebUI!

contact le vendeur de la PiZigate-Ethernet, le plugin ne fait rien de particulier que de s'assurer de la continuité du transport. Et si ca tombe, alors il relance le plugin

[deennoo]

Quelle est la version du fw de la zigate Ethernet ? je pense en 1.5c


J'aussi eu ce soucis sur la mienne (reçu fin aout), depuis elle a hiverner, je la ressort pour passer en 1.5c (juste fait attention car sur la mienne en 1.5c je n'arrive plus a me connecter au ssid zigate-xxxx, le mdp donner sur le tuto (adminxxxx) ne fonctionne pas)

En lisant tes descriptions de pannes, je penses que tu pourrais essayer de désactiver le webserver car :
"Add disable web function when TCP is opened. With some devices, when the console log is ON, there is a conflict and bring on a "errno 104 reset by peer"

Est indiqué comme l'une des pannes possible de la Zigate Ethernet