Jmqtt deamon stop et redemarre

[lolo_95]

Bonjour,
Je rencontre un problème avec Jmqtt.
J’ai des interruption de service par intermittance.
J’ai reinstallé les dependances (un topic en parlait), toujours pareil.
J’ai reinstallé mon mosquitto sur une vm toute propre, idem.
Voici les logs jmqttd que j’ai put chopé au moment ou ça tombe:

0466|[2023-05-15 22:57:18,501][INFO] Client1107      Brk1107Th       on_message() : Message received (topic="zigbee/piscine_pompe", payload="{"child_lock":"UNLOCK","current":0,"energy":33.02,"indicator_mode":"off/on","linkquality":21,"power":0,"state":"OFF","voltage":228}", QoS=0, retain=False)
0467|[2023-05-15 22:57:18,501][DEBUG] JMsg.Snd        Brk1107Th       send_async() : Enqued the message in 0.001907ms (qToJ size 1): {'cmd': 'messageIn', 'id': '1107', 'topic': 'zigbee/piscine_pompe', 'payload': '{"child_lock":"UNLOCK","current":0,"energy":33.02,"indicator_mode":"off/on","linkquality":21,"power":0,"state":"OFF","voltage":228}', 'qos': 0, 'retain': False}
0468|[2023-05-15 22:57:18,555][DEBUG] JMsg.Snd        SockOut           _loopSnd() : Sending 1 messages (0 left in queue)
0469|[2023-05-15 22:57:18,568][DEBUG] JMsg.Snd        SockOut               send() : Sent TO Jeedom 1 messages handled in 12.687445ms (qToJ size 0): [{'cmd': 'messageIn', 'id': '1107', 'topic': 'zigbee/piscine_pompe', 'payload': '{"child_lock":"UNLOCK","current":0,"energy":33.02,"indicator_mode":"off/on","linkquality":21,"power":0,"state":"OFF","voltage":228}', 'qos': 0, 'retain': False}]
0470|[2023-05-15 22:57:24,378][ERROR] JMsg.Rcv        MainThread      is_working() : Nothing has been received for 135s (max 135s), Jeedom does not want me any longer.
0471|[2023-05-15 22:57:24,479][INFO] Main            MainThread        shutdown() : Stop jMQTT python daemon
0472|[2023-05-15 22:57:24,479][DEBUG] JMsg.Rcv        MainThread   receiver_stop() : Stop requested
0473|[2023-05-15 22:57:24,547][INFO] JMsg.Rcv        SockIn            _loopRcv() : Stopped
0474|[2023-05-15 22:57:24,547][DEBUG] JMsg.Rcv        MainThread   receiver_stop() : Stopped
0475|[2023-05-15 22:57:24,547][DEBUG] JMsg.Snd        Brk1201Th       send_async() : Enqued the message in 0.003338ms (qToJ size 1): {'cmd': 'brokerDown', 'id': '1201'}
0476|[2023-05-15 22:57:24,548][INFO] Client1201      Brk1201Th    on_disconnect() : Disconnected from broker.
0477|[2023-05-15 22:57:24,548][DEBUG] Client1201      MainThread            stop() : jMqttClient ended
0478|[2023-05-15 22:57:24,548][DEBUG] Client571       MainThread            stop() : jMqttClient ended
0479|[2023-05-15 22:57:24,548][DEBUG] JMsg.Snd        Brk1095Th       send_async() : Enqued the message in 0.002146ms (qToJ size 2): {'cmd': 'brokerDown', 'id': '1095'}
0480|[2023-05-15 22:57:24,548][INFO] Client1095      Brk1095Th    on_disconnect() : Disconnected from broker.
0481|[2023-05-15 22:57:24,549][DEBUG] Client1095      MainThread            stop() : jMqttClient ended
0482|[2023-05-15 22:57:24,549][DEBUG] JMsg.Snd        Brk1082Th       send_async() : Enqued the message in 0.002146ms (qToJ size 3): {'cmd': 'brokerDown', 'id': '1082'}
0483|[2023-05-15 22:57:24,549][INFO] Client1082      Brk1082Th    on_disconnect() : Disconnected from broker.
0484|[2023-05-15 22:57:24,550][DEBUG] Client1082      MainThread            stop() : jMqttClient ended
0485|[2023-05-15 22:57:24,550][DEBUG] JMsg.Snd        Brk1107Th       send_async() : Enqued the message in 0.002861ms (qToJ size 4): {'cmd': 'brokerDown', 'id': '1107'}
0486|[2023-05-15 22:57:24,550][INFO] Client1107      Brk1107Th    on_disconnect() : Disconnected from broker.
0487|[2023-05-15 22:57:24,551][DEBUG] Client1107      MainThread            stop() : jMqttClient ended
0488|[2023-05-15 22:57:24,551][DEBUG] JMsg.Snd        Brk1322Th       send_async() : Enqued the message in 0.001669ms (qToJ size 5): {'cmd': 'brokerDown', 'id': '1322'}
0489|[2023-05-15 22:57:24,551][INFO] Client1322      Brk1322Th    on_disconnect() : Disconnected from broker.
0490|[2023-05-15 22:57:24,552][DEBUG] Client1322      MainThread            stop() : jMqttClient ended
0491|[2023-05-15 22:57:24,552][DEBUG] JMsg.Snd        Brk1542Th       send_async() : Enqued the message in 0.002146ms (qToJ size 6): {'cmd': 'brokerDown', 'id': '1542'}
0492|[2023-05-15 22:57:24,552][INFO] Client1542      Brk1542Th    on_disconnect() : Disconnected from broker.
0493|[2023-05-15 22:57:24,552][DEBUG] Client1542      MainThread            stop() : jMqttClient ended
0494|[2023-05-15 22:57:24,553][DEBUG] Main            MainThread        shutdown() : Sent Daemon Down signal to Jeedom
0495|[2023-05-15 22:57:24,553][DEBUG] JMsg.Snd        MainThread     sender_stop() : Stop requested
0496|[2023-05-15 22:57:24,580][INFO] JMsg.Snd        SockOut           _loopSnd() : Stopped
0497|[2023-05-15 22:57:24,580][DEBUG] JMsg.Snd        MainThread     sender_stop() : Stopped
0498|[2023-05-15 22:57:24,797][DEBUG] JMsg.Snd        MainThread            send() : Sent TO Jeedom 1 messages handled in 217.529774ms (qToJ size 0): [{'cmd': 'daemonDown'}]
0499|[2023-05-15 22:57:24,798][DEBUG] root            MainThread        <module>() : Exit 0

et puis cela repart.
j’ai ça aussi dans les logs jmqttd, je ne sais pas si c’est normal.

0095|[2023-05-15 23:02:16,869][INFO] Client1322      Brk1322Th       on_message() : Message received (topic="zwave/SalleAManger/Lampe_Ambience/lastActive", payload="{"time":1684184537520,"value":1684184537520}", QoS=1, retain=False)
0096|[2023-05-15 23:02:16,869][DEBUG] JMsg.Snd        Brk1322Th       send_async() : Enqued the message in 0.003338ms (qToJ size 1): {'cmd': 'messageIn', 'id': '1322', 'topic': 'zwave/SalleAManger/Lampe_Ambience/lastActive', 'payload': '{"time":1684184537520,"value":1684184537520}', 'qos': 1, 'retain': False}
0097|[2023-05-15 23:02:16,875][DEBUG] JMsg.Snd        SockOut               send() : Sent TO Jeedom 1 messages handled in 16.595125ms (qToJ size 1): [{'cmd': 'messageIn', 'id': '1322', 'topic': 'zwave/SalleAManger/Lampe_Ambience/50/0/value/66561', 'payload': '{"time":1684184537439,"value":246.03}', 'qos': 1, 'retain': False}]
0098|[2023-05-15 23:02:16,875][DEBUG] JMsg.Snd        SockOut           _loopSnd() : Sending 1 messages (0 left in queue)
0099|[2023-05-15 23:02:16,883][DEBUG] JMsg.Snd        SockOut               send() : Sent TO Jeedom 1 messages handled in 7.672787ms (qToJ size 0): [{'cmd': 'messageIn', 'id': '1322', 'topic': 'zwave/SalleAManger/Lampe_Ambience/lastActive', 'payload': '{"time":1684184537520,"value":1684184537520}', 'qos': 1, 'retain': False}]
0100|[2023-05-15 23:02:16,886][DEBUG] Main            MainThread             run() : Heartbeat received from Jeedom
0101|[2023-05-15 23:02:16,886][INFO] Main            MainThread     h_newClient() : Client already exists for Broker 571. Restarting it.
0102|[2023-05-15 23:02:16,886][DEBUG] Client571       MainThread            stop() : jMqttClient ended
0103|[2023-05-15 23:02:16,887][ERROR] Client571       MainThread           start() : jMqttClient.start() Exception
0104|Traceback (most recent call last):
0105|File "/var/www/html/plugins/jMQTT/resources/jmqttd/jMqttClient.py", line 235, in start
0106|self.mqttclient.connect(self.mqtthostname, self.mqttport, 30)
0107|File "/var/www/html/plugins/jMQTT/resources/jmqttd/venv/lib/python3.7/site-packages/paho/mqtt/client.py", line 914, in connect
0108|return self.reconnect()
0109|File "/var/www/html/plugins/jMQTT/resources/jmqttd/venv/lib/python3.7/site-packages/paho/mqtt/client.py", line 1044, in reconnect
0110|sock = self._create_socket_connection()
0111|File "/var/www/html/plugins/jMQTT/resources/jmqttd/venv/lib/python3.7/site-packages/paho/mqtt/client.py", line 3685, in _create_socket_connection
0112|return socket.create_connection(addr, timeout=self._connect_timeout, source_address=source)
0113|File "/usr/lib/python3.7/socket.py", line 727, in create_connection
0114|raise err
0115|File "/usr/lib/python3.7/socket.py", line 716, in create_connection
0116|sock.connect(sa)
0117|ConnectionRefusedError: [Errno 111] Connection refused
0118|[2023-05-15 23:02:16,889][INFO] Client1322      Brk1322Th       on_message() : Message received (topic="zwave/SalleAManger/Lampe_Ambience/50/0/value/66561", payload="{"time":1684184537539,"value":246.03}", QoS=1, retain=False)
0119|[2023-05-15 23:02:16,889][DEBUG] JMsg.Snd        Brk1322Th       send_async() : Enqued the message in 0.001907ms (qToJ size 1): {'cmd': 'messageIn', 'id': '1322', 'topic': 'zwave/SalleAManger/Lampe_Ambience/50/0/value/66561', 'payload': '{"time":1684184537539,"value":246.03}', 'qos': 1, 'retain': False}

si quelqu’un a une idée ?
pour info jmqtt_dep:

0000|======================================================================
0001|== 15/05/2023 09:16:24 == Dependencies installation for jMQTT
0002|======================================================================
0003|[  0% ] : Checking parameters...
0004|== System: Linux jeedom-vm 4.19.0-23-amd64 #1 SMP Debian 4.19.269-1 (2022-12-20) x86_64 GNU/Linux
0005|== Jeedom version: 4.3.17
0006|== jMQTT version: 2023-04-15
0007|[  9% ] : Checking parameters : [  OK  ]
0008|[ 10% ] : Synchronize the package index...
0009|[ 19% ] : Synchronize the package index : [  OK  ]
0010|[ 20% ] : Install Composer...
0011|[ 29% ] : Install Composer : [  OK  ]
0012|[ 30% ] : Install JsonPath-PHP library...
0013|[ 39% ] : Install JsonPath-PHP library : [  OK  ]
0014|[ 40% ] : Remove Composer...
0015|[ 49% ] : Remove Composer : [  OK  ]
0016|[ 50% ] : Install python3 venv and pip debian packages...
0017|[ 59% ] : Install python3 venv and pip debian packages : [  OK  ]
0018|[ 60% ] : Create a python3 Virtual Environment...
0019|[ 69% ] : Create a python3 Virtual Environment : [  OK  ]
0020|[ 70% ] : Install required python3 libraries in venv...
0021|[ 99% ] : Install required python3 libraries in venv : [  OK  ]
0022|[100% ] : Finished !
0023|======================================================================
0024|== OK == Installation Successful
0025|======================================================================

Jeedom version 4.3.17

[Bad]

Hello,

Tu utilises probablement le même ClientId sur un autre équipement MQTT

[lolo_95]

bonsoir, @Bad
Tu peux precisé « le meme clientId sur un autre equipement Mqtt »

[lolo_95]

C’est le « nom simplifié » dan zigbeetomqtt par exemple?

[Bad]

Tu peux me faire une capture d’écran de la tab Broker ton équipement Broker stp ?

[lolo_95]

[lolo_95]

Tu veux tout les équipements? j’en ai un centaine

[lolo_95]

[lolo_95]

[lolo_95]

[lolo_95]

[lolo_95]

[lolo_95]

[lolo_95]

Bon voilà, tout est au dessus.

[Bad]

J’aimerais juste l’onglet « Broker » de l’équipement broker « Mosquitto Broker Jeedom » qui ne marche pas stp

Ça a déjà marché ? Si oui, qu’as tu changé depuis ?

Et surtout, pourquoi as tu autant d’équipements Broker ???

[lolo_95]

Voici l’onglet broker de Jeedom (que j’ai desactivé, je ne m’en sert plus)

Ça a déjà marché ? Si oui, qu’as tu changé depuis ?

Oui, cela fonctionnais bien, je pense que j’ai commencé à avoir des problèmes lors de la dernière mise à jour. Des modules qui ne répondais pas bien, par exemple.
Mais je m’en occupe que depuis samedi !

Et surtout, pourquoi as tu autant d’équipements Broker ???

Et bien, au début c’était tout mélangé, donc un broker pour tout (dans le broker jeedom d’ailleur), mais cela à été vite le bordel. Donc j’ai modifier la config pour avoir un broker par protocole d’origine. d’où la multiplication. Cela fait bien 2 ans qu’il y en à plusieurs, et je n’ai eu aucun problème avec.

[lolo_95]

En voilà un autre qui est demarré, ou on voit le dernier demarrage à 23h

J’ai vérifier mes clientId, je n’en ai pas d’identique, comme tu le vois, ils sont construit avec le nom de protocole de base. Style zwave pour le zwave, Valetudo-RE pour le robot aspirateur, etc

[Bad]

Ok je comprends, rien d’anormal donc sur les screenshots, je regarde ça demain matin, la je ne suis pas devant le pc

[lolo_95]

Merci pour ton temps.
Moi c’est l’heure de dodo.

[lolo_95]

Bonjour @Bad
Alors voici les logs jmqtt, cela continue:

et jmqttd:

Les logs sont en défaut.
Voilà à quelle heure la dernière fois que les broker on été redémarré:

J’ai lu un topic sur les cron trop long qui pouvais générer des erreurs, suite au modification du core pour éliminé les processus fantôme.
J’ai celui-ci, qui dépasse les 100s:

sinon les autres sont en dessous de 74s.
Je me demande si les redémarrage ne viennent pas de là?