RFXCOM planté : cherche cause

Plugins
1

Bonsoir

Je viens de m’apercevoir que je n’ai plus de RFXCom, plus de sonde orégon, de module chacon et volet somfy RTS

Je viens d’installer aujourd’hui :
MQTT discovery
MQTT manager
Theengs Gateway

Et Supprimer le Plugin BLEA

J’avais fait avant la mise a jour du core en 4.4.9 et RFCOM du 11/06/2024 qui précise :

Le plugin est moins strict sur le firmware du rfxcom (autorisation de firmware non à jour)

Mais dans les LOG de RFXCOMcmd j’ai :

Timeout waiting status, is your rfxcom firmware up to date ?

Il faut flasher le RFXCOM (pas fait depuis longtemps, mais pas d’évolution de module…) ?

Capture du 2024-07-26 21-07-39
Capture du 2024-07-26 21-07-391595×339 62.8 KB

Informations Jeedom Atlas

Core : 4.4.9 (V4-stable)
DNS Jeedom Atlas : oui

Plugin : RFXcom
Version : 2024-06-12 01:02:41 (stable)
Statut Démon : Démarré - (2024-07-26 20:52:53)
2

Bonjour
Il faudrait la log complète en débug pour faire une analyse

3

Salut

Comment son géré les ports usb ?

Antoine

4

Je viens de passer en debug les log au niveau rfxcom, mais curieusement la page des log est longue à charger 1 minutes.
Et c’est celle de rfxcomd (5616.8 Mo) qui est très longue et débouche sur une page vide même si on voit 5616.8 Mo.

Dans HTTP.error, j’ai ça :

0565|job 21068 at Fri Jul 26 10:01:00 2024
0566|[Fri Jul 26 13:27:59.174362 2024] [access_compat:error] [pid 3739227] [client 192.168.1.21:49578] AH01797: client denied by server configuration: /var/www/html/shelly
0567|[Fri Jul 26 15:12:37.145917 2024] [access_compat:error] [pid 3688532] [client 192.168.1.21:50684] AH01797: client denied by server configuration: /var/www/html/shelly
0568|warning: commands will be executed using /bin/sh
0569|job 21069 at Fri Jul 26 15:28:00 2024
0570|[Fri Jul 26 17:41:38.209160 2024] [access_compat:error] [pid 3807581] [client 192.168.1.21:53520] AH01797: client denied by server configuration: /var/www/html/shelly
0571|[Fri Jul 26 18:28:58.929261 2024] [access_compat:error] [pid 3859613] [client 192.168.1.11:36526] AH01797: client denied by server configuration: /var/www/html/plugins/zigbee/core/config/devices/undefined, referer: http://jeedomatlas.local/index.php?v=d&m=zigbee&p=zigbee
0572|[Fri Jul 26 18:29:23.826338 2024] [access_compat:error] [pid 3861157] [client 192.168.1.11:35022] AH01797: client denied by server configuration: /var/www/html/plugins/zigbee/core/config/devices/undefined, referer: http://jeedomatlas.local/index.php?v=d&m=zigbee&p=zigbee
0573|[Fri Jul 26 18:41:33.690696 2024] [access_compat:error] [pid 3807849] [client 192.168.1.11:50724] AH01797: client denied by server configuration: /var/www/html/plugins/widget, referer: http://jeedomatlas.local/index.php?v=d&p=plan&plan_id=1
0574|[Fri Jul 26 20:22:01.203438 2024] [access_compat:error] [pid 3875139] [client 192.168.1.21:55284] AH01797: client denied by server configuration: /var/www/html/shelly
0575|[Fri Jul 26 21:02:46.783092 2024] [php7:error] [pid 3896467] [client 192.168.1.11:59230] PHP Fatal error:  Allowed memory size of 536870912 bytes exhausted (tried to allocate 4096 bytes) in /var/www/html/core/class/log.class.php on line 305
0576|[Fri Jul 26 21:02:59.229035 2024] [php7:error] [pid 3896471] [client 192.168.1.11:33562] PHP Fatal error:  Allowed memory size of 536870912 bytes exhausted (tried to allocate 4096 bytes) in /var/www/html/core/class/log.class.php on line 305
0577|[Fri Jul 26 21:03:11.762393 2024] [php7:error] [pid 3908477] [client 192.168.1.11:58222] PHP Fatal error:  Allowed memory size of 536870912 bytes exhausted (tried to allocate 4096 bytes) in /var/www/html/core/class/log.class.php on line 305
0578|[Fri Jul 26 21:03:24.475817 2024] [php7:error] [pid 3884940] [client 192.168.1.11:60192] PHP Fatal error:  Allowed memory size of 536870912 bytes exhausted (tried to allocate 4096 bytes) in /var/www/html/core/class/log.class.php on line 305
0579|[Fri Jul 26 21:35:38.685668 2024] [php7:error] [pid 3807581] [client 192.168.1.11:52574] PHP Fatal error:  Allowed memory size of 536870912 bytes exhausted (tried to allocate 4096 bytes) in /var/www/html/core/class/log.class.php on line 305
0580|[Fri Jul 26 21:35:50.498840 2024] [php7:error] [pid 3910624] [client 192.168.1.11:52628] PHP Fatal error:  Allowed memory size of 536870912 bytes exhausted (tried to allocate 4096 bytes) in /var/www/html/core/class/log.class.php on line 305
0581|[Fri Jul 26 21:36:02.335045 2024] [php7:error] [pid 3912869] [client 192.168.1.11:53268] PHP Fatal error:  Allowed memory size of 536870912 bytes exhausted (tried to allocate 4096 bytes) in /var/www/html/core/class/log.class.php on line 305
0582|[Fri Jul 26 21:36:15.521973 2024] [php7:error] [pid 3910624] [client 192.168.1.11:42132] PHP Fatal error:  Allowed memory size of 536870912 bytes exhausted (tried to allocate 4096 bytes) in /var/www/html/core/class/log.class.php on line 305
0583|[Fri Jul 26 22:10:07.637914 2024] [php7:error] [pid 3926318] [client 192.168.1.11:50090] PHP Fatal error:  Allowed memory size of 536870912 bytes exhausted (tried to allocate 4096 bytes) in /var/www/html/core/class/log.class.php on line 305
0584|[Fri Jul 26 22:10:21.024201 2024] [php7:error] [pid 3908477] [client 192.168.1.11:50130] PHP Fatal error:  Allowed memory size of 536870912 bytes exhausted (tried to allocate 4096 bytes) in /var/www/html/core/class/log.class.php on line 305
0585|[Fri Jul 26 22:10:34.362972 2024] [php7:error] [pid 3912869] [client 192.168.1.11:38364] PHP Fatal error:  Allowed memory size of 536870912 bytes exhausted (tried to allocate 4096 bytes) in /var/www/html/core/class/log.class.php on line 305
0586|[Fri Jul 26 22:10:47.670479 2024] [php7:error] [pid 3932915] [client 192.168.1.11:36110] PHP Fatal error:  Allowed memory size of 536870912 bytes exhausted (tried to allocate 4096 bytes) in /var/www/html/core/class/log.class.php on line 305
0587|[Fri Jul 26 22:13:40.053525 2024] [php7:error] [pid 3908477] [client 192.168.1.11:48046] PHP Fatal error:  Allowed memory size of 536870912 bytes exhausted (tried to allocate 4096 bytes) in /var/www/html/core/class/log.class.php on line 305
0588|[Fri Jul 26 22:13:53.299511 2024] [php7:error] [pid 3866546] [client 192.168.1.11:53642] PHP Fatal error:  Allowed memory size of 536870912 bytes exhausted (tried to allocate 4096 bytes) in /var/www/html/core/class/log.class.php on line 305
0589|[Fri Jul 26 22:14:06.546002 2024] [php7:error] [pid 3933590] [client 192.168.1.11:59294] PHP Fatal error:  Allowed memory size of 536870912 bytes exhausted (tried to allocate 4096 bytes) in /var/www/html/core/class/log.class.php on line 305
0590|[Fri Jul 26 22:14:22.922043 2024] [php7:error] [pid 3866546] [client 192.168.1.11:41924] PHP Fatal error:  Allowed memory size of 536870912 bytes exhausted (tried to allocate 4096 bytes) in /var/www/html/core/class/log.class.php on line 305
0591|[Fri Jul 26 22:14:48.595213 2024] [php7:error] [pid 3912869] [client 192.168.1.11:53894] PHP Fatal error:  Allowed memory size of 536870912 bytes exhausted (tried to allocate 4096 bytes) in /var/www/html/core/class/log.class.php on line 305
0592|[Fri Jul 26 22:15:02.798377 2024] [php7:error] [pid 3935452] [client 192.168.1.11:50616] PHP Fatal error:  Allowed memory size of 536870912 bytes exhausted (tried to allocate 4096 bytes) in /var/www/html/core/class/log.class.php on line 305
0593|[Fri Jul 26 22:15:16.966901 2024] [php7:error] [pid 3934045] [client 192.168.1.11:54562] PHP Fatal error:  Allowed memory size of 536870912 bytes exhausted (tried to allocate 4096 bytes) in /var/www/html/core/class/log.class.php on line 305
0594|[Fri Jul 26 22:15:30.695611 2024] [php7:error] [pid 3912869] [client 192.168.1.11:50652] PHP Fatal error:  Allowed memory size of 536870912 bytes exhausted (tried to allocate 4096 bytes) in /var/www/html/core/class/log.class.php on line 305
5

Comment ça ???

6

Vide tous les logs relance le démon et si nok redonne la log.

7

OK

J’ai tout vidé les Log et relancé le démon du RFXCOM et curieusement c’est reparti… ??

Les Log:

rfxcom :

0000|[2024-07-26 22:30:25] INFO  : Lancement démon rfxcomd : /usr/bin/python3 /var/www/html/plugins/rfxcom/resources/rfxcomd/rfxcomd.py --device /dev/serial/by-id/usb-RFXCOM_RFXtrx433_A1Y06XE5-if00-port0 --loglevel debug --socketport 55000 --serialrate 38400 --protocol 4,18,21 --callback http://127.0.0.1:80/plugins/rfxcom/core/php/jeeRfxcom.php --apikey ZqljguiN1DTMQlcWun5L3wO7TtqvyfR8pwdmnhwhpTkTIknR --cycle 0.3 --pid /tmp/jeedom/rfxcom/deamon.pid
0001|[2024-07-26 22:30:28] INFO  : Démon RFXcom lancé
0002|[2024-07-26 22:30:31] DEBUG  : {"devices":{"BC0252":{"packettype":"0x52","subtype":"0x01","id":"BC02","temperature":"21.5","humidity":90,"humidity_status":3,"battery":100,"rssi":5}}}
0003|[2024-07-26 22:30:43] DEBUG  : {"devices":{"F10452":{"packettype":"0x52","subtype":"0x01","id":"F104","temperature":"21.0","humidity":76,"humidity_status":3,"battery":10,"rssi":5}}}
0004|[2024-07-26 22:30:50] DEBUG  : {"devices":{"F70152":{"packettype":"0x52","subtype":"0x01","id":"F701","temperature":"22.8","humidity":75,"humidity_status":3,"battery":100,"rssi":5}}}
0005|[2024-07-26 22:31:11] DEBUG  : {"devices":{"BC0252":{"packettype":"0x52","subtype":"0x01","id":"BC02","temperature":"21.5","humidity":90,"humidity_status":3,"battery":100,"rssi":5}}}
0006|[2024-07-26 22:31:26] DEBUG  : {"devices":{"F10452":{"packettype":"0x52","subtype":"0x01","id":"F104","temperature":"21.0","humidity":76,"humidity_status":3,"battery":10,"rssi":5}}}
0007|[2024-07-26 22:31:29] DEBUG  : {"devices":{"F70152":{"packettype":"0x52","subtype":"0x01","id":"F701","temperature":"22.8","humidity":75,"humidity_status":3,"battery":100,"rssi":5}}}
0008|[2024-07-26 22:31:52] DEBUG  : {"devices":{"BC0252":{"packettype":"0x52","subtype":"0x01","id":"BC02","temperature":"21.5","humidity":90,"humidity_status":3,"battery":100,"rssi":5}}}
0009|[2024-07-26 22:32:08] DEBUG  : {"devices":{"F70152":{"packettype":"0x52","subtype":"0x01","id":"F701","temperature":"22.8","humidity":75,"humidity_status":3,"battery":100,"rssi":5}}}
0010|[2024-07-26 22:32:09] DEBUG  : {"devices":{"F10452":{"packettype":"0x52","subtype":"0x01","id":"F104","temperature":"21.0","humidity":76,"humidity_status":3,"battery":10,"rssi":5}}}
0011|[2024-07-26 22:32:33] DEBUG  : {"devices":{"BC0252":{"packettype":"0x52","subtype":"0x01","id":"BC02","temperature":"21.5","humidity":90,"humidity_status":3,"battery":100,"rssi":5}}}
0012|[2024-07-26 22:32:47] DEBUG  : {"devices":{"F70152":{"packettype":"0x52","subtype":"0x01","id":"F701","temperature":"22.8","humidity":75,"humidity_status":3,"battery":100,"rssi":5}}}
0013|[2024-07-26 22:32:52] DEBUG  : {"devices":{"F10452":{"packettype":"0x52","subtype":"0x01","id":"F104","temperature":"21.0","humidity":76,"humidity_status":3,"battery":10,"rssi":5}}}
0014|[2024-07-26 22:33:14] DEBUG  : {"devices":{"BC0252":{"packettype":"0x52","subtype":"0x01","id":"BC02","temperature":"21.5","humidity":90,"humidity_status":3,"battery":100,"rssi":5}}}
0015|[2024-07-26 22:33:26] DEBUG  : {"devices":{"F70152":{"packettype":"0x52","subtype":"0x01","id":"F701","temperature":"22.8","humidity":75,"humidity_status":3,"battery":100,"rssi":5}}}
0016|[2024-07-26 22:33:35] DEBUG  : {"devices":{"F10452":{"packettype":"0x52","subtype":"0x01","id":"F104","temperature":"21.0","humidity":76,"humidity_status":3,"battery":10,"rssi":6}}}
0017|[2024-07-26 22:33:55] DEBUG  : {"devices":{"BC0252":{"packettype":"0x52","subtype":"0x01","id":"BC02","temperature":"21.5","humidity":90,"humidity_status":3,"battery":100,"rssi":5}}}
0018|[2024-07-26 22:34:05] DEBUG  : {"devices":{"F70152":{"packettype":"0x52","subtype":"0x01","id":"F701","temperature":"22.8","humidity":75,"humidity_status":3,"battery":100,"rssi":5}}}
0019|[2024-07-26 22:34:18] DEBUG  : {"devices":{"F10452":{"packettype":"0x52","subtype":"0x01","id":"F104","temperature":"21.0","humidity":76,"humidity_status":3,"battery":10,"rssi":6}}}
0020|[2024-07-26 22:34:36] DEBUG  : {"devices":{"BC0252":{"packettype":"0x52","subtype":"0x01","id":"BC02","temperature":"21.4","humidity":90,"humidity_status":3,"battery":100,"rssi":5}}}
0021|[2024-07-26 22:34:44] DEBUG  : {"devices":{"F70152":{"packettype":"0x52","subtype":"0x01","id":"F701","temperature":"22.8","humidity":75,"humidity_status":3,"battery":100,"rssi":5}}}
0022|[2024-07-26 22:35:01] DEBUG  : {"devices":{"F10452":{"packettype":"0x52","subtype":"0x01","id":"F104","temperature":"21.0","humidity":76,"humidity_status":3,"battery":10,"rssi":6}}}
0023|[2024-07-26 22:35:17] DEBUG  : {"devices":{"BC0252":{"packettype":"0x52","subtype":"0x01","id":"BC02","temperature":"21.4","humidity":90,"humidity_status":3,"battery":100,"rssi":5}}}
0024|[2024-07-26 22:35:23] DEBUG  : {"devices":{"F70152":{"packettype":"0x52","subtype":"0x01","id":"F701","temperature":"22.8","humidity":75,"humidity_status":3,"battery":100,"rssi":5}}}
0025|[2024-07-26 22:35:44] DEBUG  : {"devices":{"F10452":{"packettype":"0x52","subtype":"0x01","id":"F104","temperature":"21.0","humidity":76,"humidity_status":3,"battery":10,"rssi":6}}}
0026|[2024-07-26 22:35:58] DEBUG  : {"devices":{"BC0252":{"packettype":"0x52","subtype":"0x01","id":"BC02","temperature":"21.4","humidity":90,"humidity_status":3,"battery":100,"rssi":5}}}
0027|[2024-07-26 22:36:02] DEBUG  : {"devices":{"F70152":{"packettype":"0x52","subtype":"0x01","id":"F701","temperature":"22.8","humidity":75,"humidity_status":3,"battery":100,"rssi":5}}}
0028|[2024-07-26 22:36:27] DEBUG  : {"devices":{"F10452":{"packettype":"0x52","subtype":"0x01","id":"F104","temperature":"21.0","humidity":76,"humidity_status":3,"battery":10,"rssi":6}}}
0029|[2024-07-26 22:36:39] DEBUG  : {"devices":{"BC0252":{"packettype":"0x52","subtype":"0x01","id":"BC02","temperature":"21.4","humidity":90,"humidity_status":3,"battery":100,"rssi":6}}}
0030|[2024-07-26 22:36:41] DEBUG  : {"devices":{"F70152":{"packettype":"0x52","subtype":"0x01","id":"F701","temperature":"22.8","humidity":75,"humidity_status":3,"battery":100,"rssi":5}}}
0031|[2024-07-26 22:37:10] DEBUG  : {"devices":{"F10452":{"packettype":"0x52","subtype":"0x01","id":"F104","temperature":"21.0","humidity":76,"humidity_status":3,"battery":10,"rssi":5}}}
0032|[2024-07-26 22:37:53] DEBUG  : {"devices":{"F10452":{"packettype":"0x52","subtype":"0x01","id":"F104","temperature":"21.0","humidity":76,"humidity_status":3,"battery":10,"rssi":6}}}
0033|[2024-07-26 22:37:59] DEBUG  : {"devices":{"F70152":{"packettype":"0x52","subtype":"0x01","id":"F701","temperature":"22.8","humidity":75,"humidity_status":3,"battery":100,"rssi":5}}}
0034|[2024-07-26 22:38:01] DEBUG  : {"devices":{"BC0252":{"packettype":"0x52","subtype":"0x01","id":"BC02","temperature":"21.4","humidity":90,"humidity_status":3,"battery":100,"rssi":5}}}


rfxcomd : 
[rfxcomd.txt|attachment](upload://lUWhjsbUzQ9IzsPD595O7L8PuVY.txt) (59,8 Ko)
8

À mon avis c’était un soucis de place dû à la taille du log. La question c’est plutôt pourquoi jeedom n’arrivait pas à le vider sachant qu’il est censé le faire toute les 24h. À moins que le le log ce soit rempli trop vite

9

Je pense qu’on pourrait passer la beta en stable, il y a une correction de bug sur la beta qui potentiellement pourrait résoudre un cas où le log se rempli en boucle
impossible à dire ici sans avoir vu le log avec le problème évidemment mais ca ne peut pas faire de mal

@Tam85 tu peux toujours installer la beta, confirmer que ca tourne correctement
mais impossible de savoir si cela corrigera le problème sans que cela ne se reproduise et le soucis de base est probablement sur la connexion avec le rfxcom (hardware, cable, os… aucune idée) donc quasi impossible à reproduire pour tester

10

Ce sont les Log de rfxcomd qui se remplissaient rapidement je voyais défiler cette ligne :

[2024-07-26 22:30:13][ERROR] : Timeout waiting status, is your rfxcom firmware up to date ?

Plusieurs centaines de fois pour la même seconde.
11

Ok je me le note j’essaye de le faire dans la journée

12

Je fais un Backup et je charge la beta ce matin.

Edit : Beta en place depuis 9h30
Edit : 12h30, je ne constate pas d’anomalie, rien dans les log.

1 « J'aime »
13

Ce sujet a été automatiquement fermé après 24 heures suivant le dernier commentaire. Aucune réponse n’est permise dorénavant.