Equipements Arlo identifiés comme en timeout

guipom · Octobre 17, 2024, 12:20

Bonjour,

Depuis une petite semaine j’ai régulièrement tous mes équipements Arlo qui passent en timeout; Ca se repère par la petite icone horloge orange, mais aussi mes scénarios qui vérifient que tout va bien.
Je n’ai pas de soucis de connexion internet ou autre.
Dans le doute il y a quelques jours j’ai rebooté la base Arlo, j’ai réinstallé les dépendances, redémarré le démon.

Mais c’est revenu aujourd’hui !

Je ne sais pas si ce problème est lié à mon installation, à l’infra Arlo ou autre chose, je n’ai pas trop vu de problèmes similaires sur le forum.

Informations Jeedom Atlas

Core : 4.4.18 (master)
DNS Jeedom Atlas : oui

Plugin : Arlo
Version : 2024-09-24 01:20:37 (stable)
Statut Démon : Démarré - (2024-10-14 09:36:04)

Informations complémentaires

Log des dépendances:


======================================================================
== 14/10/2024 09:35:16 == Dependencies installation for arlo
======================================================================
[  5% ] : Clean apt...
[  9% ] : Clean apt : [  OK  ]
[ 10% ] : Update apt...
[ 14% ] : Update apt : [  OK  ]
[ 15% ] : Install apt packages...
[ 19% ] : Install apt packages : [  OK  ]
[ 20% ] : Init python3 & prerequisites...
[ 29% ] : Init python3 & prerequisites : [  OK  ]
[ 30% ] : Init PyEnv...
** PyEnv not required: 3.9.2 >= 3.9 **
** python3 path: python3 **
[ 39% ] : Init PyEnv : [  OK  ]
[ 40% ] : Setting up virtual environment...
** Version of python in VENV: Python 3.9.2
[ 69% ] : Setting up virtual environment : [  OK  ]
[ 70% ] : Install the required python packages...
[ 79% ] : Install the required python packages : [  OK  ]
[ 80% ] : Restoring folders and files rights...
[ 89% ] : Restoring folders and files rights : [  OK  ]
[ 90% ] : Summary of installed packages...
aiohappyeyeballs==2.4.0
aiohttp==3.10.5
aiosignal==1.3.1
async-timeout==4.0.3
attrs==24.2.0
certifi==2024.2.2
cffi==1.17.1
charset-normalizer==3.3.2
cloudscraper==1.2.71
cryptography==43.0.1
frozenlist==1.4.1
idna==3.7
jeedomdaemon==0.11.2
monotonic==1.6
multidict==6.1.0
paho-mqtt==2.1.0
pkg_resources==0.0.0
pycparser==2.22
pyparsing==3.1.2
requests==2.32.3
requests-toolbelt==1.0.0
six==1.16.0
sseclient==0.0.18
typing_extensions==4.12.2
Unidecode==1.3.8
urllib3==2.2.1
yarl==1.11.1
[ 99% ] : Summary of installed packages : [  OK  ]
[100% ] : Finished !
======================================================================
== OK == Installation Successful
======================================================================

Log du démon:


[2024-10-17 13:46:07][ERROR] : failed to read modes (v2)
[2024-10-17 13:51:07][ERROR] : failed to read modes (v2)
[2024-10-17 13:51:07][ERROR] : job-error=TypeError
Traceback (most recent call last):
File "/var/www/html/plugins/arlo/resources/arlod/pyaarlo/background.py", line 35, in _run_next
job["callback"](**job["args"])
File "/var/www/html/plugins/arlo/resources/arlod/pyaarlo/__init__.py", line 427, in _refresh_modes
base.update_mode()
File "/var/www/html/plugins/arlo/resources/arlod/pyaarlo/base.py", line 395, in update_mode
for mode in data:
TypeError: 'NoneType' object is not iterable
[2024-10-17 13:56:07][ERROR] : failed to read modes (v2)
[2024-10-17 13:57:07][ERROR] : failed to read modes (v2)
[2024-10-17 13:57:07][ERROR] : job-error=TypeError
Traceback (most recent call last):
File "/var/www/html/plugins/arlo/resources/arlod/pyaarlo/background.py", line 35, in _run_next
job["callback"](**job["args"])
File "/var/www/html/plugins/arlo/resources/arlod/pyaarlo/__init__.py", line 427, in _refresh_modes
base.update_mode()
File "/var/www/html/plugins/arlo/resources/arlod/pyaarlo/base.py", line 395, in update_mode
for mode in data:
TypeError: 'NoneType' object is not iterable
[2024-10-17 14:02:07][ERROR] : failed to read modes (v2)
[2024-10-17 14:02:07][ERROR] : job-error=TypeError
Traceback (most recent call last):
File "/var/www/html/plugins/arlo/resources/arlod/pyaarlo/background.py", line 35, in _run_next
job["callback"](**job["args"])
File "/var/www/html/plugins/arlo/resources/arlod/pyaarlo/__init__.py", line 427, in _refresh_modes
base.update_mode()
File "/var/www/html/plugins/arlo/resources/arlod/pyaarlo/base.py", line 395, in update_mode
for mode in data:
TypeError: 'NoneType' object is not iterable
[2024-10-17 14:06:07][ERROR] : failed to read modes (v2)
[2024-10-17 14:08:07][ERROR] : failed to read modes (v2)
[2024-10-17 14:08:07][ERROR] : job-error=TypeError
Traceback (most recent call last):
File "/var/www/html/plugins/arlo/resources/arlod/pyaarlo/background.py", line 35, in _run_next
job["callback"](**job["args"])
File "/var/www/html/plugins/arlo/resources/arlod/pyaarlo/__init__.py", line 427, in _refresh_modes
base.update_mode()
File "/var/www/html/plugins/arlo/resources/arlod/pyaarlo/base.py", line 395, in update_mode
for mode in data:
TypeError: 'NoneType' object is not iterable
[2024-10-17 14:14:07][ERROR] : failed to read modes (v2)
[2024-10-17 14:14:07][ERROR] : job-error=TypeError
Traceback (most recent call last):
File "/var/www/html/plugins/arlo/resources/arlod/pyaarlo/background.py", line 35, in _run_next
job["callback"](**job["args"])
File "/var/www/html/plugins/arlo/resources/arlod/pyaarlo/__init__.py", line 427, in _refresh_modes
base.update_mode()
File "/var/www/html/plugins/arlo/resources/arlod/pyaarlo/base.py", line 395, in update_mode
for mode in data:
TypeError: 'NoneType' object is not iterable
[2024-10-17 14:16:07][ERROR] : failed to read modes (v2)
[2024-10-17 14:19:07][ERROR] : failed to read modes (v2)
[2024-10-17 14:19:07][ERROR] : job-error=TypeError
Traceback (most recent call last):
File "/var/www/html/plugins/arlo/resources/arlod/pyaarlo/background.py", line 35, in _run_next
job["callback"](**job["args"])
File "/var/www/html/plugins/arlo/resources/arlod/pyaarlo/__init__.py", line 427, in _refresh_modes
base.update_mode()
File "/var/www/html/plugins/arlo/resources/arlod/pyaarlo/base.py", line 395, in update_mode
for mode in data:
TypeError: 'NoneType' object is not iterable

Log du plugin:


rien !

Merci ! et je peux ajouter plus d’infos ou changer le niveau de logs, si nécessaire.

Mips · Octobre 17, 2024, 12:26

Salut,

en « timeout » c’est la notion de « non communication du core » dont tu parles? càd qu’aucune commande info n’a été mise à jour depuis x minutes?

je n’ai vu aucun problème similaire (et je n’ai aucun problème personnellement)
là effectivement le démon est mort donc normal que les équipements soient en « timeout ».

si tu redémarres le démon, ca repart j’imagine?
il faudrait voir qu’elle est la première erreur qui se produit qui fait ensuite tout planter

edit: et merci pour le post complet

guipom · Octobre 17, 2024, 12:31

Alors le démon est « mort » mais pas vraiment mort en fait:

Ce n’est pas vraiment visible dans le plugin ou la page santé

Si je le rédémarre, ca repart pour quelques temps oui, mais je reviens dans cet état à un moment donné et je ne sais pas bien comment.

Pour le timeout, c’est l’alert de « name » « Timeout »:
$alert = $eqLogic->getAlert()[« name »];
if ($alert == « Timeout ») {

Ce qui est similaire je pense à l’icone timeout qu’on trouve sur les widgets, absence de communication:

je n’ai pas redémarré cette fois ci, des fois qu’il y ait quelque chose à vérifier !

Mips · Octobre 17, 2024, 12:40

ah oui ca j’avais bien compris, sinon il se serait remis tout seul ou au pire il aurait redémarré

du coup c’est ca que je voudrais trouver pour pouvoir, je l’espère, gérer ce cas dans le démon et qu’il se rétablisse tout seul
donc ma piste ca serait d’avoir la première erreur qui se produit, j’espère qu’il y aura un message un peu plus parlant qui permettra que je sache quoi intercepter.
=> tu n’as rien dans le log avant ce jour 13h46?

as-tu des caméras de la gamme « essential »? c’est la principal différence dans la beta

ok on parle de la même chose.

tu peux redémarrer alors, éventuellement avec le log level à INFO mais du coup prendre le prochain log rapidement lorsque ca plante

guipom · Octobre 17, 2024, 12:58

Des produits essentials, oui probablement, mais tout est connecté sur ma base, je ne suis pas dans une situation mixte Wi-Fi direct et base Arlo. Tous mes équipements sont connectés sur une base station VMB5000.

Je suis allé voir les logs, mais j’ai un truncated log pour le démon.

J’ai tout nettoyé et tout redémarré, mais quand ca part en cacahuète c’est assez verbeux, du coup je perds l’erreur initiale.

Voilà les produits que j’ai :

0001|[2024-10-17 14:57:06] INFO  : Checking commands of 'Cave' - deviceType/modelId:'camera/VMC5040'
0002|[2024-10-17 14:57:06] INFO  : Checking commands of 'Jardin' - deviceType/modelId:'camera/VMC5040'
0003|[2024-10-17 14:57:07] INFO  : Checking commands of 'Sonnette' - deviceType/modelId:'doorbell/AVD2001B'
0004|[2024-10-17 14:57:07] INFO  : Checking commands of 'Indoor' - deviceType/modelId:'camera/VMC2040B'
0005|[2024-10-17 14:57:08] INFO  : Checking commands of 'Floodlight' - deviceType/modelId:'camera/FB1001B'
0006|[2024-10-17 14:57:08] INFO  : Checking commands of 'Garage' - deviceType/modelId:'camera/VMC5040'
0007|[2024-10-17 14:57:09] INFO  : Checking commands of 'VMB5000' - deviceType/modelId:'basestation/VMB5000'

guipom · Octobre 22, 2024, 9:07

C’est retombé encore en panne, je m’en suis rendu compte quand les sirènes se sont déclenchées en retrant chez moi, jeedom ne communique plus avec arlo.

Sauf que je suis dans l’embarras, c’est la même chose que l’autre fois, les logs sont trop verbeux, je n’ai pas l’erreur racine. Juste:

[2024-10-22 06:57:05] ERROR  : failed to read modes (v2)
[2024-10-22 07:01:05] ERROR  : failed to read modes (v2)
[2024-10-22 07:01:05] ERROR  : job-error=TypeError
Traceback (most recent call last):
File "/var/www/html/plugins/arlo/resources/arlod/pyaarlo/background.py", line 35, in _run_next
job["callback"](**job["args"])
File "/var/www/html/plugins/arlo/resources/arlod/pyaarlo/__init__.py", line 427, in _refresh_modes
base.update_mode()
File "/var/www/html/plugins/arlo/resources/arlod/pyaarlo/base.py", line 395, in update_mode
for mode in data:
TypeError: 'NoneType' object is not iterable

qui se répète …

Et côté logs plugin, juste les rapports de status

[2024-10-21 09:56:05] INFO  : Active mode for 5GP60C79A0A4B => mode1 / activé
[2024-10-21 10:01:05] INFO  : Active mode for 5GP60C79A0A4B => mode1 / activé
[2024-10-21 10:07:05] INFO  : Active mode for 5GP60C79A0A4B => mode1 / activé
[2024-10-21 10:12:05] INFO  : Active mode for 5GP60C79A0A4B => mode1 / activé
[2024-10-21 10:17:05] INFO  : Active mode for 5GP60C79A0A4B => mode1 / activé
[2024-10-21 10:23:05] INFO  : Active mode for 5GP60C79A0A4B => mode1 / activé
[2024-10-21 19:09:23] INFO  : Active mode for 5GP60C79A0A4B => mode1 / activé
[2024-10-22 04:00:04] INFO  : Deleting /var/www/html/plugins/arlo/data/records/A5U10BWJ01788/20240921202942647725.jpg
[2024-10-22 04:00:04] INFO  : Deleting /var/www/html/plugins/arlo/data/records/A5U10BWJ01788/20240921122200663018.jpg
[2024-10-22 04:00:04] INFO  : Deleting /var/www/html/plugins/arlo/data/records/A5U10BWJ01788/20240921122132396367.jpg
[2024-10-22 04:00:04] INFO  : Deleting /var/www/html/plugins/arlo/data/records/A5U10BWJ01788/20240921122105641638.jpg
[2024-10-22 04:00:04] INFO  : Active mode for 5GP60C79A0A4B => mode1 / activé

Il y a un problème, mais je ne suis pas capable de savoir lequel et de le remonter !

Le heartbeat avec redémarrage de démon semble inopérant en attendant, vu que le démon est identifié comme démarré, ce qui n’est pas vraiment le cas puisqu’il est crashé.

Mips · Octobre 22, 2024, 9:18

Le heartbeat ne tient pas compte du fait que le démon soit indiqué ok justement. Au contraire, il ne s’occupe pas des démons marqués comme nok.

Ce qu’il fait c’est redémarrer les démons qui sont pourtant indiqués ok si et seulement si aucun équipement du plugin concerné n’a été mis à jour depuis les x minutes configurées car justement ca serait un signe que le démon ne fait plus son boulot même s’il est supposé être ok.

Donc si le heartbeat ne fait rien c’est que certaines infos remontent encore.

Je vais creuser de mon côté voir si je trouve une piste.

guipom · Octobre 22, 2024, 9:53

Si jamais tu as une idée pour que je puisse remonter à l’erreur initiale, d’une manière ou d’une autre, je peux essayer.
Je ne sais pas si je peux en toute sécurité augmenter le nombre de lignes des fichiers de logs, c’est 500 par défaut, mais c’est global pour tout (core et plugins)

Mips · Octobre 27, 2024, 11:34

Avec la beta dispo demain j’ai mis en place un check pour tenter d’éviter le blocage du démon dans le cas de l’erreur de refresh sur le mode.
Cela ne résoudra pas le problème de refresh mais celui-ci est potentiellement dû à un petit problème temporaire coté Arlo.

Donc à voir si ca tient mieux avec ça.

guipom · Octobre 27, 2024, 8:48

Merci pour l’info.
Ton message tombe bien, j’ai toujours le problème mais le heartbeat (60 minutes, redémarrage) limite la gêne. Par contre je le vois se bloquer, peut etre une fois tous les deux jours.

Le soucis principal étant que je n’ai pas accès à la cause d’origine, il se met ensuite à logguer très rapidement et ca sature les logs démons.

J’essayerai de basculer sur la béta demain soir, pour voir si j’observe quelque chose ! Merci !

guipom · Octobre 28, 2024, 8:45

C’est basculé, je suis en beta.
J’ai enlevé le heartbeat démon, pour etre sûr de repérer si ca retombe.

guipom · Novembre 3, 2024, 9:01

Ca fait plusieurs jours que je tourne avec la version beta, pour l’instant je n’ai rien de suspicieux dans les logs, le démon n’est pas tombé. En général ça m’arrivait tous les 2/3 jours.

guipom · Novembre 14, 2024, 9:54

Je vais être obligé de repasser en stable, je dois ouvrir un incident support et il y a malheureusement toujours cette limitation de ne pas pouvoir ouvrir un incident quand on a un plugin beta.
Tu penses que cette correction pourra etre poussée en stable, ou il faudra creuser plus ? je n’ai plus de soucis, meme si j’observe de temps en temps des warnings de communication dans les logs (j’ai tout reset à cause de mes tests sur l’IPX800), je pourrai te les transmettre plus tard pour confirmation.

Merci !

Mips · Novembre 15, 2024, 7:21

oui, j’attendais plus ou moins une confirmation que c’était toujours ok.
j’ai validé pour la stable, ca sera dispo demain.

guipom · Novembre 15, 2024, 9:18

C’est super, merci.
De toute façon je continue à surveiller de près.

Je devais juste te montrer le log qui doit je pense être affiché dans le cas qui avons me poser problème, mais j’ai bêtement tout réinitialisé hier en essayant d’isoler un autre problème.

Je te tiens au courant (en beta ou stable)
Merci!

system · Novembre 28, 2024, 2:28

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