Timeout de connexion avec l'envoy depuis le passage en V7

Hello,

J’étais en train de chercher, un peu pourquoi j’avais quasi tous les jours à la même heure depuis le passage de l’envoy en v7 un timeout… Et je tombe sur le post de Tian.Rero sur le sujet :

Il se trouve que j’ai le même message a la même heure quasi tous les jours.

0149|[2023-07-08 23:05:04]ERROR : Erreur sur la fonction cron du plugin : Echec de la requête HTTP : https://192.168.1.50/production.json?details=1 cURL error : Operation timed out after 20001 milliseconds with 0 bytes received
0150|[2023-07-09 23:04:04]ERROR : Erreur sur la fonction cron du plugin : Echec de la requête HTTP : https://192.168.1.50/production.json?details=1 cURL error : Operation timed out after 20001 milliseconds with 0 bytes received
0151|[2023-07-11 23:04:04]ERROR : Erreur sur la fonction cron du plugin : Echec de la requête HTTP : https://192.168.1.50/production.json?details=1 cURL error : Operation timed out after 20001 milliseconds with 0 bytes received
0152|[2023-07-13 23:04:03]ERROR : Erreur sur la fonction cron du plugin : Echec de la requête HTTP : https://192.168.1.50/production.json?details=1 cURL error : Operation timed out after 20001 milliseconds with 0 bytes received
0153|[2023-07-14 23:04:03]ERROR : Erreur sur la fonction cron du plugin : Echec de la requête HTTP : https://192.168.1.50/production.json?details=1 cURL error : Operation timed out after 20000 milliseconds with 0 bytes received
0154|[2023-07-15 23:02:04]ERROR : Erreur sur la fonction cron du plugin : Echec de la requête HTTP : https://192.168.1.50/production.json?details=1 cURL error : Operation timed out after 20001 milliseconds with 0 bytes received
0155|[2023-07-16 23:02:03]ERROR : Erreur sur la fonction cron du plugin : Echec de la requête HTTP : https://192.168.1.50/production.json?details=1 cURL error : Operation timed out after 20000 milliseconds with 0 bytes received
0156|[2023-07-20 20:54:43]ERROR : Erreur sur la fonction cron du plugin : Echec de la requête HTTP : https://192.168.1.50/production.json?details=1 cURL error : Failed to connect to 192.168.1.50 port 443: No route to host (coupure de courant)
0157|[2023-07-20 23:02:03]ERROR : Erreur sur la fonction cron du plugin : Echec de la requête HTTP : https://192.168.1.50/production.json?details=1 cURL error : Operation timed out after 20000 milliseconds with 0 bytes received
0158|[2023-07-21 23:02:03]ERROR : Erreur sur la fonction cron du plugin : Echec de la requête HTTP : https://192.168.1.50/production.json?details=1 cURL error : Operation timed out after 20000 milliseconds with 0 bytes received
0159|[2023-07-22 23:02:05]ERROR : Erreur sur la fonction cron du plugin : Echec de la requête HTTP : https://192.168.1.50/production.json?details=1 cURL error : Operation timed out after 20001 milliseconds with 0 bytes received
0160|[2023-07-23 23:02:04]ERROR : Erreur sur la fonction cron du plugin : Echec de la requête HTTP : https://192.168.1.50/production.json?details=1 cURL error : Operation timed out after 20001 milliseconds with 0 bytes received
0161|[2023-07-24 13:06:20]ERROR : Erreur sur la fonction cron du plugin : Echec de la requête HTTP : https://192.168.1.50/production.json?details=1 cURL error : Failed to connect to 192.168.1.50 port 443: No route to host (reboot de ma box)
0162|[2023-07-24 13:07:24]ERROR : Erreur sur la fonction cron du plugin : Echec de la requête HTTP : https://192.168.1.50/production.json?details=1 cURL error : Failed to connect to 192.168.1.50 port 443: No route to host (reboot de ma box)
0163|[2023-07-24 23:02:03]ERROR : Erreur sur la fonction cron du plugin : Echec de la requête HTTP : https://192.168.1.50/production.json?details=1 cURL error : Operation timed out after 20001 milliseconds with 0 bytes received
0164|[2023-07-25 23:02:03]ERROR : Erreur sur la fonction cron du plugin : Echec de la requête HTTP : https://192.168.1.50/production.json?details=1 cURL error : Operation timed out after 20000 milliseconds with 0 bytes received

Étrangement au début c’était 23h05 puis 23h04 et depuis le 15/07 c’est 23h02…

Du coup, ce n’est pas forcement un problème sur le plugin en question, il y a peut être des cron a 23h02 qui charge un peu le jeedom (ou l’os (Debian 11) (ou un truc sur l’envoy)

Je vois rien de particulier dans les cron à 23h02 par rapport a ce qui se fait autour.
Je n’ai pas de cron « perso » à cette heure là non plus.

Jul 25 22:57:01 jeedom-j3455 CRON[903357]: (www-data) CMD (/usr/bin/php /var/www/html/core/php/jeeCron.php >> /dev/null)
Jul 25 22:58:01 jeedom-j3455 CRON[904833]: (www-data) CMD (/usr/bin/php /var/www/html/core/php/jeeCron.php >> /dev/null)
Jul 25 22:59:02 jeedom-j3455 CRON[906311]: (www-data) CMD (/usr/bin/php /var/www/html/core/php/jeeCron.php >> /dev/null)
Jul 25 23:00:01 jeedom-j3455 CRON[907767]: (www-data) CMD (/usr/bin/php /var/www/html/core/php/jeeCron.php >> /dev/null)
Jul 25 23:00:01 jeedom-j3455 CRON[907768]: (root) CMD (/usr/bin/php /var/www/html/core/php/watchdog.php >> /dev/null)
Jul 25 23:00:01 jeedom-j3455 CRON[907769]: (root) CMD (   /root/scripts/cp-graph-jeedom.sh > /dev/null 2>&1)
Jul 25 23:00:01 jeedom-j3455 systemd[1]: Starting system activity accounting tool...
Jul 25 23:00:01 jeedom-j3455 systemd[1]: sysstat-collect.service: Succeeded.
Jul 25 23:00:01 jeedom-j3455 systemd[1]: Finished system activity accounting tool.
Jul 25 23:01:01 jeedom-j3455 CRON[909630]: (www-data) CMD (/usr/bin/php /var/www/html/core/php/jeeCron.php >> /dev/null)
Jul 25 23:02:01 jeedom-j3455 CRON[911105]: (www-data) CMD (/usr/bin/php /var/www/html/core/php/jeeCron.php >> /dev/null)
Jul 25 23:03:01 jeedom-j3455 CRON[912546]: (www-data) CMD (/usr/bin/php /var/www/html/core/php/jeeCron.php >> /dev/null)
Jul 25 23:04:01 jeedom-j3455 CRON[914004]: (www-data) CMD (/usr/bin/php /var/www/html/core/php/jeeCron.php >> /dev/null)

Est-ce que d’autres ont ces erreurs (à des heures différentes peut-être).

Je n’avais pas ces erreurs en V5.

Peut-être que l’envoy en V7 fait d’autre chose à heure fixe qui allonge le délai de réponse de celle-ci.

@Loic le timeout à 2s est global à Jeedom pour les requêtes externes ou il est modifiable pour un plugins en particulier ? Ex: mettre 3 secondes le temps de voir si ça change quelque chose… (C’est peut-être niveau apache ou php ?)

Edit: Ce n’est absolument pas bloquant, c’est juste space d’avoir une erreur par jour tous les jours… Le reste de la journée RAS et il ne se passe de toutes façons rien à 23h02… Le soleil dort depuis longtemps chez nous.

Merci pour vos retour !
Bonne journée

Bonjour,
Le timeout est a 20s pas 2s… c’est l’envoy qui desfois ne réponds pas, rien a voir avec leur ou quoi. Pour info en beta il y a maintenant 30s et un retry depuis je n’ai plus le soucis chez moi.

Au temps pour moi, 20 secondes oui.

C’est quand même toujours à la même heure 10 jours de suite :slight_smile:
Après si avec un retry et timout plus long ça ne pose plus de souci j’attendrai la prochaine version stable :wink:

Chez toi chez moi ca change tous les jours, ca doit dépendre de ce que fais l’envoy au moment de la demande.

Oki doki, attendons la futur stable pour les retry qui vont bien.
Rien de bien urgent, merci pour les retours. :slight_smile:

Bonjour,
j’ai toujours la même erreur.
Cela se produisait pendant 30 minutes environ à des heures de la journée assez aléatoire.
J’ai changé de canaux sur ma connexion WIFI et là cela fait 3 jours que l’erreur apparait à 23h02 précise.

Bonjour,
Es tu en beta ? Si non c’est normal ma correction pour ce soucis qui vient de l’envoy qui des fois est débordé et ne répond est que en beta. Je tiens a préciser c’est une possible correction car le soucis de base ne peut être corrigé que par enphase moi je peux juste le cacher.

Ok merci
Je suis en version stable en effet.

C’est quand même space que pour deux personne ce soit toujours a 23h02 que ça pose problème :slight_smile:
Sinon, perso depuis le 26/07 je n’ai plus d’erreur.

0149|[2023-07-08 23:05:04]ERROR : Erreur sur la fonction cron du plugin : Echec de la requête HTTP : https://192.168.1.50/production.json?details=1 cURL error : Operation timed out after 20001 milliseconds with 0 bytes received
0150|[2023-07-09 23:04:04]ERROR : Erreur sur la fonction cron du plugin : Echec de la requête HTTP : https://192.168.1.50/production.json?details=1 cURL error : Operation timed out after 20001 milliseconds with 0 bytes received
0151|[2023-07-11 23:04:04]ERROR : Erreur sur la fonction cron du plugin : Echec de la requête HTTP : https://192.168.1.50/production.json?details=1 cURL error : Operation timed out after 20001 milliseconds with 0 bytes received
0152|[2023-07-13 23:04:03]ERROR : Erreur sur la fonction cron du plugin : Echec de la requête HTTP : https://192.168.1.50/production.json?details=1 cURL error : Operation timed out after 20001 milliseconds with 0 bytes received
0153|[2023-07-14 23:04:03]ERROR : Erreur sur la fonction cron du plugin : Echec de la requête HTTP : https://192.168.1.50/production.json?details=1 cURL error : Operation timed out after 20000 milliseconds with 0 bytes received
0154|[2023-07-15 23:02:04]ERROR : Erreur sur la fonction cron du plugin : Echec de la requête HTTP : https://192.168.1.50/production.json?details=1 cURL error : Operation timed out after 20001 milliseconds with 0 bytes received
0155|[2023-07-16 23:02:03]ERROR : Erreur sur la fonction cron du plugin : Echec de la requête HTTP : https://192.168.1.50/production.json?details=1 cURL error : Operation timed out after 20000 milliseconds with 0 bytes received
0156|[2023-07-20 20:54:43]ERROR : Erreur sur la fonction cron du plugin : Echec de la requête HTTP : https://192.168.1.50/production.json?details=1 cURL error : Failed to connect to 192.168.1.50 port 443: No route to host
0157|[2023-07-20 23:02:03]ERROR : Erreur sur la fonction cron du plugin : Echec de la requête HTTP : https://192.168.1.50/production.json?details=1 cURL error : Operation timed out after 20000 milliseconds with 0 bytes received
0158|[2023-07-21 23:02:03]ERROR : Erreur sur la fonction cron du plugin : Echec de la requête HTTP : https://192.168.1.50/production.json?details=1 cURL error : Operation timed out after 20000 milliseconds with 0 bytes received
0159|[2023-07-22 23:02:05]ERROR : Erreur sur la fonction cron du plugin : Echec de la requête HTTP : https://192.168.1.50/production.json?details=1 cURL error : Operation timed out after 20001 milliseconds with 0 bytes received
0160|[2023-07-23 23:02:04]ERROR : Erreur sur la fonction cron du plugin : Echec de la requête HTTP : https://192.168.1.50/production.json?details=1 cURL error : Operation timed out after 20001 milliseconds with 0 bytes received
0161|[2023-07-24 13:06:20]ERROR : Erreur sur la fonction cron du plugin : Echec de la requête HTTP : https://192.168.1.50/production.json?details=1 cURL error : Failed to connect to 192.168.1.50 port 443: No route to host
0162|[2023-07-24 13:07:24]ERROR : Erreur sur la fonction cron du plugin : Echec de la requête HTTP : https://192.168.1.50/production.json?details=1 cURL error : Failed to connect to 192.168.1.50 port 443: No route to host
0163|[2023-07-24 23:02:03]ERROR : Erreur sur la fonction cron du plugin : Echec de la requête HTTP : https://192.168.1.50/production.json?details=1 cURL error : Operation timed out after 20001 milliseconds with 0 bytes received
0164|[2023-07-25 23:02:03]ERROR : Erreur sur la fonction cron du plugin : Echec de la requête HTTP : https://192.168.1.50/production.json?details=1 cURL error : Operation timed out after 20000 milliseconds with 0 bytes received
0165|[2023-07-26 23:02:04]ERROR : Erreur sur la fonction cron du plugin : Echec de la requête HTTP : https://192.168.1.50/production.json?details=1 cURL error : Operation timed out after 20001 milliseconds with 0 bytes received

L’envoy est toujours en D7.6.175 je ne sais pas si c’est pareil chez vous.

Sinon à noter, le 26 midi, j’ai ajouté 4G de swap sur mon jeedom et restart le plugin xiaomihome qui est très (trop ?) consommateur de ressource :

www-data 2041083  1.6 22.9 2103712 1834048 ?     Sl   juil.26 193:44 /usr/bin/python3 /var/www/html/plugins/xiaomihome/resources/xiaomihomed/xiaomihomed.py --loglevel error --socketport 55019 --callback http://192.168.1.101/plugins/xiaomihome/core/php/jeeXiaomiHome.php --apikey c0crarEduDUAsAIejqdEbL48Lb5d0asD --cycle 0.05 --pid /tmp/jeedom/xiaomihome/deamon.pid

# free -h
               total       utilisé      libre     partagé tamp/cache   disponible
Mem:           7,6Gi       3,6Gi       471Mi        25Mi       3,5Gi       3,7Gi
Partition d'échange:      5,0Gi       488Mi       4,5Gi

Et depuis le 27 du coup plus de problème de timeout envoy.
Je vais faire un petit w toutes les minutes quelques jour voir le load à 23h02 afin de savoir si il se passe un truc.

Après si c’était un problème de ressource du au manque de swap & co, il n’aurait pas du y avoir le log du 26 au soir, vu que j’ai clean le système le 26 midi.

Cela dit, depuis le 27/07, plus de timeout je ne l’explique pas.

Vous êtes tous en D7.6.175 sur votre envoy ?

Bonne journée :slight_smile:

Bonjour
Le timeout n’a rien a voir avec jeedom mais avec l’envoy et l’heure et peut être du au faite que chez vous ya une tâche dans l’envoy a cette heure là (calcul de la production solaire de la journée par exemple) et donc cette tâche étant lourde empêche elle empêche l’envoy de répondre aux autres demandes.

Hello Loic,

Oui je pense aussi que le souci est coté envoy, ça a commencer après le passage en V7 de celles-ci donc c’est assez évident.
C’est pour ça que je demandais vos versions, pour savoir si quelque chose avait changé depuis le 27/07, je m’étonnes juste qu’1j après l’ajout de swap les problèmes disparaissent (peut être temporairement), sans doute encore un coup de l’ami Murphy :slight_smile:
Il est aussi possible qu’Enphase aient fait des mises à jour de leur côté (pas sur les envoy) qui font que l’envoy charge moins depuis quelques jour et n’est plus/moins de problème à répondre.