Deamon en erreur toutes les heures

Tags: #<Tag:0x00007f384e53de18>

donnes les log en mode debug

ainsi que la copie d’ecran de la configuration du demon

Je viens de vérifier en live :

  • A 11:35:0X, le deamon passe en KO
  • Il reste KO pendant 5 minutes
  • A 11:40:0X, le deamon passe en OK

Voila pour la configuration du plugin.
image

Voici les dernières logs du plugin :

[2020-10-01 11:35:05][DEBUG] : ================= CRON pour l'actualisation de : Appareils connectés Wifi Invité ==================
[2020-10-01 11:35:05][DEBUG] : ================= CRON pour l'actualisation de : Freebox Débits ==================
[2020-10-01 11:35:05][DEBUG] : ┌───────── Début de Mise à jour
[2020-10-01 11:35:05][DEBUG] : │ [Freebox Request Connexion] : GET sur la l'adresse 192.168.0.XXX/api/v8/connection/(null)
[2020-10-01 11:35:05][DEBUG] : │ [Freebox Request Result] : {"uid":"XXX","success":false,"msg":"Vous devez vous connecter pour accéder à cette fonction","result":{"password_salt":"ZZZ","challenge":"YYY"},"error_code":"auth_required"}
[2020-10-01 11:35:05][DEBUG] : [Redémarrage session à cause de l'erreur] : auth_required
[2020-10-01 11:35:05][DEBUG] : [Freebox Close Session] : {"uid":"XXX","success":false,"msg":"Vous devez vous connecter pour accéder à cette fonction","result":{"password_salt":"ZZZ","challenge":"YYY"},"error_code":"invalid_session"}
[2020-10-01 11:35:05][DEBUG] : [Freebox Password] : {"success":true,"result":{"logged_in":false,"challenge":"YYY","password_salt":"ZZZ","password_set":true}}
[2020-10-01 11:35:06][DEBUG] : [get Freebox Open Session Data] : {"result":{"session_token":"TOKEN","challenge":"YYY","password_salt":"ZZZ","permissions":{"parental":false,"contacts":true,"explorer":true,"tv":true,"wdo":true,"downloader":true,"profile":true,"camera":true,"settings":true,"calls":true,"home":true,"pvr":true,"vm":true,"player":true},"password_set":true},"success":true}
[2020-10-01 11:35:06][DEBUG] : [Redémarrage session Terminée à cause de l'erreur] : auth_required
[2020-10-01 11:35:06][DEBUG] : ================= CRON pour l'actualisation de : Freebox Player ==================
[2020-10-01 11:35:06][DEBUG] : ================= CRON pour l'actualisation de : Contrôle ==================
[2020-10-01 11:39:04][DEBUG] : ================= PAS DE CRON pour d'actualisation Air Média à cause du Démon : nok ==================
[2020-10-01 11:39:04][DEBUG] : ================= PAS DE CRON pour d'actualisation Appareils connectés à cause du Démon : nok ==================
[2020-10-01 11:39:04][DEBUG] : ================= PAS DE CRON pour d'actualisation Appareils connectés Wifi Invité à cause du Démon : nok ==================
[2020-10-01 11:39:04][DEBUG] : ================= PAS DE CRON pour d'actualisation Disque Dur à cause du Démon : nok ==================
[2020-10-01 11:39:04][DEBUG] : ================= PAS DE CRON pour d'actualisation Freebox Débits à cause du Démon : nok ==================
[2020-10-01 11:39:04][DEBUG] : ================= PAS DE CRON pour d'actualisation Freebox Player à cause du Démon : nok ==================
[2020-10-01 11:39:04][DEBUG] : ================= PAS DE CRON pour d'actualisation Mattéo à cause du Démon : nok ==================
[2020-10-01 11:39:04][DEBUG] : ================= PAS DE CRON pour d'actualisation Système à cause du Démon : nok ==================
[2020-10-01 11:39:04][DEBUG] : ================= PAS DE CRON pour d'actualisation Téléchargements à cause du Démon : nok ==================
[2020-10-01 11:39:04][DEBUG] : ================= PAS DE CRON pour d'actualisation Téléphone à cause du Démon : nok ==================
[2020-10-01 11:39:04][DEBUG] : ================= PAS DE CRON pour d'actualisation Wifi à cause du Démon : nok ==================
[2020-10-01 11:40:05][DEBUG] : ================= PAS DE CRON pour d'actualisation Air Média à cause du Démon : nok ==================
[2020-10-01 11:40:05][DEBUG] : ================= PAS DE CRON pour d'actualisation Appareils connectés à cause du Démon : nok ==================
[2020-10-01 11:40:05][DEBUG] : ================= PAS DE CRON pour d'actualisation Appareils connectés Wifi Invité à cause du Démon : nok ==================
[2020-10-01 11:40:05][DEBUG] : ================= PAS DE CRON pour d'actualisation Disque Dur à cause du Démon : nok ==================
[2020-10-01 11:40:05][DEBUG] : ================= PAS DE CRON pour d'actualisation Freebox Débits à cause du Démon : nok ==================
[2020-10-01 11:40:05][DEBUG] : ================= PAS DE CRON pour d'actualisation Freebox Player à cause du Démon : nok ==================
[2020-10-01 11:40:05][DEBUG] : ================= PAS DE CRON pour d'actualisation Contrôle à cause du Démon : nok ==================
[2020-10-01 11:40:05][DEBUG] : ================= PAS DE CRON pour d'actualisation Système à cause du Démon : nok ==================
[2020-10-01 11:40:05][DEBUG] : ================= PAS DE CRON pour d'actualisation Téléchargements à cause du Démon : nok ==================
[2020-10-01 11:40:05][DEBUG] : ================= PAS DE CRON pour d'actualisation Téléphone à cause du Démon : nok ==================
[2020-10-01 11:40:05][DEBUG] : ================= PAS DE CRON pour d'actualisation Wifi à cause du Démon : nok ==================
[2020-10-01 11:40:05][DEBUG] : [Freebox Password] : {"success":true,"result":{"logged_in":false,"challenge":"YYY2","password_salt":"ZZZ","password_set":true}}
[2020-10-01 11:40:06][DEBUG] : [Freebox Open Session] : {"result":{"session_token":"TOKEN2","challenge":"YYY2","password_salt":"ZZZ","permissions":{"parental":false,"contacts":true,"explorer":true,"tv":true,"wdo":true,"downloader":true,"profile":true,"camera":true,"settings":true,"calls":true,"home":true,"pvr":true,"vm":true,"player":true},"password_set":true},"success":true}
[2020-10-01 11:43:24][DEBUG] : ┌───────── Début de Mise à jour
[2020-10-01 11:43:24][DEBUG] : │ [Freebox Request Connexion] :  sur la l'adresse 192.168.0.XXX/api/v8/airmedia/receivers/(null)
[2020-10-01 11:43:24][DEBUG] : │ [Freebox Request Result] : {"success":true,"result":[{"capabilities":{"photo":false,"screen":false,"audio":true,"video":false},"name":"Freebox Server","password_protected":false},{"capabilities":{"photo":false,"screen":false,"audio":true,"video":false},"name":"Freebox Player","password_protected":false}]}
[2020-10-01 11:43:24][DEBUG] : └─────────
[2020-10-01 11:43:25][DEBUG] : ┌───────── Début de Mise à jour
[2020-10-01 11:43:25][DEBUG] : │ [Freebox Request Connexion] :  sur la l'adresse 192.168.0.XXX/api/v8/airmedia/receivers/(null)
[2020-10-01 11:43:25][DEBUG] : │ [Freebox Request Result] : {"success":true,"result":[{"capabilities":{"photo":false,"screen":false,"audio":true,"video":false},"name":"Freebox Server","password_protected":false},{"capabilities":{"photo":false,"screen":false,"audio":true,"video":false},"name":"Freebox Player","password_protected":false}]}
[2020-10-01 11:43:25][DEBUG] : └─────────
[2020-10-01 11:43:25][DEBUG] : ┌───────── Début de Mise à jour
[2020-10-01 11:43:25][DEBUG] : │ [Freebox Request Connexion] :  sur la l'adresse 192.168.0.XXX/api/v8/airmedia/receivers/(null)
[2020-10-01 11:43:25][DEBUG] : │ [Freebox Request Result] : {"success":true,"result":[{"capabilities":{"photo":false,"screen":false,"audio":true,"video":false},"name":"Freebox Server","password_protected":false},{"capabilities":{"photo":false,"screen":false,"audio":true,"video":false},"name":"Freebox Player","password_protected":false}]}
[2020-10-01 11:43:25][DEBUG] : └─────────
[2020-10-01 11:45:06][DEBUG] : ================= CRON pour l'actualisation de : Air Média ==================
[2020-10-01 11:45:06][DEBUG] : ================= CRON pour l'actualisation de : Appareils connectés ==================
[2020-10-01 11:45:06][DEBUG] : ================= CRON pour l'actualisation de : Appareils connectés Wifi Invité ==================
[2020-10-01 11:45:06][DEBUG] : ================= CRON pour l'actualisation de : Freebox Débits ==================
[2020-10-01 11:45:06][DEBUG] : ┌───────── Début de Mise à jour
[2020-10-01 11:45:06][DEBUG] : │ [Freebox Request Connexion] : GET sur la l'adresse 192.168.0.XXX/api/v8/connection/(null)
[2020-10-01 11:45:06][DEBUG] : │ [Freebox Request Result] : {"success":true,"result":{RESULT}}
[2020-10-01 11:45:06][DEBUG] : └─────────
[2020-10-01 11:45:06][DEBUG] : ┌───────── Début de Mise à jour
[2020-10-01 11:45:06][DEBUG] : │ [Freebox Request Connexion] : GET sur la l'adresse 192.168.0.XXX/api/v8/connection/config(null)
[2020-10-01 11:45:06][DEBUG] : │ [Freebox Request Result] : {"success":true,"result":{RESULT}}
[2020-10-01 11:45:06][DEBUG] : └─────────
[2020-10-01 11:45:06][DEBUG] : ┌───────── Début de Mise à jour
[2020-10-01 11:45:06][DEBUG] : │ [Freebox Request Connexion] : GET sur la l'adresse 192.168.0.XXX/api/v8/connection/ftth(null)
[2020-10-01 11:45:06][DEBUG] : │ [Freebox Request Result] : {"success":true,"result":{RESULT}}
[2020-10-01 11:45:06][DEBUG] : └─────────
[2020-10-01 11:45:06][DEBUG] : ┌───────── Début de Mise à jour
[2020-10-01 11:45:06][DEBUG] : │ [Freebox Request Connexion] : GET sur la l'adresse 192.168.0.XXX/api/v8/connection/xdsl(null)
[2020-10-01 11:45:06][DEBUG] : │ [Freebox Request Result] : {"success":true,"result":{RESULT}}
[2020-10-01 11:45:06][DEBUG] : └─────────
[2020-10-01 11:45:06][DEBUG] : ================= CRON pour l'actualisation de : Freebox Player ==================
[2020-10-01 11:45:06][DEBUG] : ================= CRON pour l'actualisation de : Contrôle ==================
[2020-10-01 11:45:06][DEBUG] : ┌───────── Début de Mise à jour
[2020-10-01 11:45:06][DEBUG] : │ [Freebox Request Connexion] : GET sur la l'adresse 192.168.0.XXX/api/v8/network_control/1(null)
[2020-10-01 11:45:06][DEBUG] : │ [Freebox Request Result] : {"success":true,"result":{RESULT}}
[2020-10-01 11:45:06][DEBUG] : └─────────
[2020-10-01 11:45:06][DEBUG] : >───────── Etat Contrôle Parental : /1
[2020-10-01 11:45:06][DEBUG] : ================= CRON pour l'actualisation de : Wifi ==================

Il rédemarre a la prochaine requête.

Je vais essayer de redémarrer le demon quand je vois le message. mais je ne promet rien

Ok, pour le moment c’est du « by design ».
Si moyen de le redémarrer c’est top, sinon il faudra s’accommoder de ces 4% d’indisponibilité.
Perso ça ne me gène pas trop (utilisation limitée) je peux contourner en excluant le deamon de mon scenario de suivi mais pour d’autres c’est peut être plus structurant.

Vu la méthode de fonctionnement, il n’y a pas d’impact.

C’est le plugin qui interroge la freebox pas l’inverse.
Donc même si le démon est arrêté entre 2 interrogations il n’y a pas de trou dans les données.

Il n’y a pas d’impact à la récupération de données mais j’imagine que si on se met à utiliser le plugin pour interagir avec des équipements c’est autre chose.
Je ne sais pas ce que permet de faire le plugin exactement avec une Freebox Delta + pack sécurité mais imaginons que tous les matins je me lève à 6h30 et qu’en descendant 10’ plus tard au RdC je souhaite désactiver l’alarme. Le deamon étant KO toutes les heures entre xx:35 et xx:40 (dans mon cas), aucun de mes scénarios qui interagissent avec les équipement ne vont fonctionner (par ex. sur détection de l’ouverture de mes volets le matin je veux désactiver l’alarme).

Comme dit par @JAG, ce n’est pas toutes les 5 minutes mais jusqu’à la prochaine requête.

Donc si tu lance une action ça redémarre le démon Puisqu’il va faire une requête à la Freebox. Ou alors j’ai mal compris sa réponse.

c’est bien cela
il fera la mise a jour de l’authentification

Je vais essayer de faire qq chose mais c’est compliqué avec Free qui fait evolué son firmware avec autant de bugs

Ok merci pour votre retour.
En attendant je vais adapter ma surveillance pour ignorer le KO du deamon.

Bonsoir,
c’est justement ce que je monitore via les timeouts des équipements jeedom, et je peux assurer que quand il y a réauthentification, on perd 1 occurrence d’acualisation sur l’équipement, Débits par ex.
Avec un timeout à 6min, ça se voit très clairement quand l’authent saute…

Voici ma log :

[2020-09-27 20:35:05][DEBUG] : ================= CRON pour l'actualisation de : Appareils connectés ==================
[2020-09-27 20:35:05][DEBUG] : ┌───────── Début de Mise à jour
[2020-09-27 20:35:05][DEBUG] : │ [Freebox Request Connexion] : GET sur la l'adresse mafreebox.freebox.fr/api/v8/lan/browser/pub(null)
[2020-09-27 20:35:05][DEBUG] : │ [Freebox Request Result] : {"uid":"blablablabla","success":false,"msg":"Vous devez vous connecter pour accéder à cette fonction","result":{"password_salt":"ZZZZZZZZZZZZZZZZZZZZZZZZZ","challenge":"ZZZZZZZZZZZZZZZZZZZZZZZ"},"error_code":"auth_required"}
[2020-09-27 20:35:05][DEBUG] : [Redémarrage session à cause de l'erreur] : auth_required
[2020-09-27 20:35:05][DEBUG] : [Freebox Close Session] : {"uid":"blablablabla","success":false,"msg":"Vous devez vous connecter pour accéder à cette fonction","result":{"password_salt":"XXXXXXXXXXXXXXXXXXXXX","challenge":"ZZZZZZZZZZZZZZZZZZZZZZZ"},"error_code":"invalid_session"}
[2020-09-27 20:35:05][DEBUG] : [Freebox Password] : {"success":true,"result":{"logged_in":false,"challenge":"ZZZZZZZZZZZZZZZZZZZZZZZZZ","password_salt":"ZZZZZZZZZZZZZZZZZZZZZZZ","password_set":true}}
[2020-09-27 20:35:05][DEBUG] : [get Freebox Open Session Data] : {"result":{"session_token":"XXXXXXXXXXXXXXXXXXXXX","challenge":"XXXXXXXXXXXXXXXXXXXXX","password_salt":"ZZZZZZZZZZZZZZZZZZZZZZZZZ","permissions":{"parental":true,"contacts":true,"explorer":true,"tv":true,"wdo":true,"downloader":true,"profile":true,"camera":true,"settings":true,"calls":true,"home":true,"pvr":true,"vm":true,"player":true},"password_set":true},"success":true}
[2020-09-27 20:35:05][DEBUG] : [Redémarrage session Terminée à cause de l'erreur] : auth_required
[2020-09-27 20:35:05][DEBUG] : │===========> RESULT Requête pas correct :
[2020-09-27 20:35:05][DEBUG] : ================= CRON pour l'actualisation de : Appareils connectés Wifi Invité ==================
[2020-09-27 20:35:05][DEBUG] : ================= CRON pour l'actualisation de : Freebox Débits ==================
[2020-09-27 20:39:03][DEBUG] : ================= PAS DE CRON pour d'actualisation Nexus 7 à cause du Démon : nok ==================
[2020-09-27 20:39:03][DEBUG] : ================= PAS DE CRON pour d'actualisation Volet velux Alice à cause du Démon : nok ==================
[2020-09-27 20:39:03][DEBUG] : ================= PAS DE CRON pour d'actualisation Volet velux Camille à cause du Démon : nok ==================
[2020-09-27 20:39:03][DEBUG] : ================= PAS DE CRON pour d'actualisation Volet velux parents à cause du Démon : nok ==================
[2020-09-27 20:39:03][DEBUG] : ================= PAS DE CRON pour d'actualisation Air Média à cause du Démon : nok ==================
[2020-09-27 20:39:03][DEBUG] : ================= PAS DE CRON pour d'actualisation Appareils connectés à cause du Démon : nok ==================
[2020-09-27 20:39:03][DEBUG] : ================= PAS DE CRON pour d'actualisation Appareils connectés Wifi Invité à cause du Démon : nok ==================
[2020-09-27 20:39:03][DEBUG] : ================= PAS DE CRON pour d'actualisation Disque Dur à cause du Démon : nok ==================
[2020-09-27 20:39:03][DEBUG] : ================= PAS DE CRON pour d'actualisation Freebox Débits à cause du Démon : nok ==================
[2020-09-27 20:39:03][DEBUG] : ================= PAS DE CRON pour d'actualisation Freebox Player à cause du Démon : nok ==================
[2020-09-27 20:39:03][DEBUG] : ================= PAS DE CRON pour d'actualisation Home Adapters à cause du Démon : nok ==================
[2020-09-27 20:39:03][DEBUG] : ================= PAS DE CRON pour d'actualisation Système à cause du Démon : nok ==================
[2020-09-27 20:39:03][DEBUG] : ================= PAS DE CRON pour d'actualisation Téléchargements à cause du Démon : nok ==================
[2020-09-27 20:39:03][DEBUG] : ================= PAS DE CRON pour d'actualisation Téléphone à cause du Démon : nok ==================
[2020-09-27 20:39:03][DEBUG] : ================= PAS DE CRON pour d'actualisation Wifi à cause du Démon : nok ==================
[2020-09-27 20:40:05][DEBUG] : ================= PAS DE CRON pour d'actualisation Nexus 7 à cause du Démon : nok ==================
[2020-09-27 20:40:05][DEBUG] : ================= PAS DE CRON pour d'actualisation Volet velux Alice à cause du Démon : nok ==================
[2020-09-27 20:40:05][DEBUG] : ================= PAS DE CRON pour d'actualisation Volet velux Camille à cause du Démon : nok ==================
[2020-09-27 20:40:05][DEBUG] : ================= PAS DE CRON pour d'actualisation Volet velux parents à cause du Démon : nok ==================
[2020-09-27 20:40:05][DEBUG] : ================= PAS DE CRON pour d'actualisation Air Média à cause du Démon : nok ==================
[2020-09-27 20:40:05][DEBUG] : ================= PAS DE CRON pour d'actualisation Appareils connectés à cause du Démon : nok ==================
[2020-09-27 20:40:05][DEBUG] : ================= PAS DE CRON pour d'actualisation Appareils connectés Wifi Invité à cause du Démon : nok ==================
[2020-09-27 20:40:05][DEBUG] : ================= PAS DE CRON pour d'actualisation Disque Dur à cause du Démon : nok ==================
[2020-09-27 20:40:05][DEBUG] : ================= PAS DE CRON pour d'actualisation Freebox Débits à cause du Démon : nok ==================
[2020-09-27 20:40:05][DEBUG] : ================= PAS DE CRON pour d'actualisation Freebox Player à cause du Démon : nok ==================
[2020-09-27 20:40:05][DEBUG] : ================= PAS DE CRON pour d'actualisation Home Adapters à cause du Démon : nok ==================
[2020-09-27 20:40:05][DEBUG] : ================= PAS DE CRON pour d'actualisation Système à cause du Démon : nok ==================
[2020-09-27 20:40:05][DEBUG] : ================= PAS DE CRON pour d'actualisation Téléchargements à cause du Démon : nok ==================
[2020-09-27 20:40:05][DEBUG] : ================= PAS DE CRON pour d'actualisation Téléphone à cause du Démon : nok ==================
[2020-09-27 20:40:05][DEBUG] : ================= PAS DE CRON pour d'actualisation Wifi à cause du Démon : nok ==================
[2020-09-27 20:40:08][DEBUG] : [Freebox Password] : {"success":true,"result":{"logged_in":false,"challenge":"XXXXXXXXXXXXXXXXXXXXX","password_salt":"ZZZZZZZZZZZZZZZZZZZZZZZ","password_set":true}}
[2020-09-27 20:40:08][DEBUG] : [Freebox Open Session] : {"result":{"session_token":"ZZZZZZZZZZZZZZZZZZZZZZZZZZZZZZZ","challenge":"ZZZZZZZZZZZZZZZZZZZZZZZZZ","password_salt":"XXXXXXXXXXXXXXXXXXXXX","permissions":{"parental":true,"contacts":true,"explorer":true,"tv":true,"wdo":true,"downloader":true,"profile":true,"camera":true,"settings":true,"calls":true,"home":true,"pvr":true,"vm":true,"player":true},"password_set":true},"success":true}
[2020-09-27 20:45:06][DEBUG] : ================= CRON pour l'actualisation de : Nexus 7 ==================

J’ai eu l’alerte de timeout à 20h41, qui prouve bien que le refresh de 20h40 n’a pas été fait malgré l’indication de la log.

hello

je sais ce qui se passe,

Je suis en train de faire quelques choses déjà pour redémarrer automatiquement l’authentification pour ne pas perdre les crons suivants

Pour le cron ou il y a eu l’erreur c’est plus compliqué a gérer.

Bonsoir JAG,
j’imagine que lorsque l’auth tombe, il faudrait relancer l’auth + reprendre les cron qui n’ont pas pu être faits, voir tous les relancer…

Pour les Crons suivants, je suis en train de tester qq chose.

Mais c’est plus compliqué pour gérer le refresh ou il y a l’erreur

C’est quoi qui grille au juste la session ? un nombre prédéterminé de requêtes ou un délai d’expiration ??

il faut demander a Free, car c’est depuis le dernier firmware.
Ils ont dût limiter le nombre de requête c’est pour cela que j’essaye de simplifier les mises à jour

J’ai fait des améliorations dans la prochaine beta

Mais là c’est le firmware de la Freebox qui pose pb

Au top, je teste d’ici ce soir.
Merci JAG

So far so good, le deamon ne tombe plus en erreur toutes les heures (je suis en beta).
Merci pour le support et la réactivité !

1 J'aime

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