Quelques comportements étranges - Calaos v3

[Arnaud]

Tiens une piste en passant...
J'utilise un boitier qui mesure des consommations électriques dans la maison (compteur général + 3 prises qui mesure). Le boitier remonte des valeurs en temps réels en série/usb sur mon Raspberry, avec une fréquence d'une mesure par seconde ou presque. Jusque là ok.

Le Rpi envoie chaque mesure à la db graph de Calaos à chaque mesure, donc il y a une requête web vers calaos pour updater une variable, qui elle est enregistrée dans la db. Cela fonctionne bien. Par contre, est-ce que par hasard si Calais reçoit une api/update toutes les 1 à 2 secondes ne lui poserait pas un problème ? Peut-être peux-tu faire une boucle script pour simuler ça également ?

[raoulh]

Oui ok, tu peux me donner ton script qui fait l'update sur calaos?

[Arnaud]

En fait, c'est un work flow node-red dont je viens de t'envoyer un screenshot par email... ça ne va pas t'aider je pense.

[raoulh]

Salut Arnaud,

J'ai fait une nouvelle image v3 avec un bug fix que j'ai corrigé ou calaos_server crashait aleatoirement.
Tu pourrais essayer voir si ca serait ca chez toi?

[Arnaud]

Oui bien sûr, je vais essayer de faire la mise à jour ce week-end si je peux !

Merci

[Fred]

Hello
J’ai également installé cette nouvelle version et calaos_server marche très bien maintenant (aucuns crashs à signaler depuis plus de 3 jours). L’erreur json avec les hue dont je t’avais parlé Raoul a l’air d’être résolu aussi 

J’ai juste ce bug d’affichage qui persiste avec les éclairages rgb (Dali et Hue). Dès que la lumière est allumée il compte de manière croissante avec un intervalle +/- 1 seconde et inversement quand j'éteins la lumière.

   
et la seule lumière qui est allumée :
   

[Arnaud]

Hello,

La mise à jour est faite, ça fonctionne bien. Bon, j'ai dû louper un truc parce qu'il a fait une installation vierge sans reprise de config, mais la config de calaos_os se fait rapidement.

Ca fonctionne pour l'instant nickel. Je regarde l'uptime du service de temps en temps.

D'ici là, passez de belles fêtes :-)

[Arnaud]

En faisant un systemctl status ce matin, il m'indique un update de 41mn, hors je me levais juste, aucune opération particulière :

root@intel-corei7-64:/etc/calaos# date; systemctl status calaos-server                  
Wed Dec 30 09:31:51 CET 2020
● calaos-server.service - Calaos home automation server service
  Loaded: loaded (/lib/systemd/system/calaos-server.service; enabled; vendor preset: enabled)
  Active: active (running) since Wed 2020-12-30 08:50:15 CET; 41min ago
 Process: 4033 ExecStartPre=/bin/mkdir -p /home/root/.cache/calaos /etc/calaos (code=exited, status=0/SUCCESS)
Main PID: 4034 (calaos_server)
   Tasks: 3 (limit: 4915)
  Memory: 10.4M
  CGroup: /system.slice/calaos-server.service
          ├─4034 /usr/bin/calaos_server --config /etc/calaos --cache /home/root/.cache/calaos
          └─4036 /usr/bin/calaos_wago --socket /tmp/calaos_proc_ca5b4da0-e256-f23e-c00e-0f6eadb9c718_wago_4034 --namespace wago 192.168.0.1 502

Dec 30 09:31:41 intel-corei7-64 calaos_server[4034]: [CRI] network (HttpClient.cpp:151) Error sending data ! Closing connection.
Dec 30 09:31:42 intel-corei7-64 calaos_server[4034]: [INF] output (IntValue.cpp:122) intern_33: got action, 4
Dec 30 09:31:42 intel-corei7-64 calaos_server[4034]: [CRI] network (HttpClient.cpp:151) Error sending data ! Closing connection.
Dec 30 09:31:47 intel-corei7-64 calaos_server[4034]: [INF] output (IntValue.cpp:122) intern_34: got action, 0
Dec 30 09:31:47 intel-corei7-64 calaos_server[4034]: [CRI] network (HttpClient.cpp:151) Error sending data ! Closing connection.
Dec 30 09:31:47 intel-corei7-64 calaos_server[4034]: [INF] websocket (WebSocket.cpp:446) Received a PONG back in 00:00
Dec 30 09:31:47 intel-corei7-64 calaos_server[4034]: [INF] output (IntValue.cpp:122) intern_35: got action, 108
Dec 30 09:31:47 intel-corei7-64 calaos_server[4034]: [CRI] network (HttpClient.cpp:151) Error sending data ! Closing connection.
Dec 30 09:31:48 intel-corei7-64 calaos_server[4034]: [INF] output (IntValue.cpp:122) intern_33: got action, 4
Dec 30 09:31:48 intel-corei7-64 calaos_server[4034]: [CRI] network (HttpClient.cpp:151) Error sending data ! Closing connection.

Ce qui montre que le service a redémarré ou crashé il y a 41mn. Sniff..

[raoulh]

@arnaud, mince... la il me faudrait plus de detail pour reproduire....

@Fred: Nouvelle version avec ton bug corrigé ici: https://www.calaos.fr/download/experimen...-03.tar.xz

Tu peux tester stp et me faire un retour? merci

[Arnaud]

Du coup, qu'est-ce que je peux produire comme log peut-être ?

Côté dmesg, il y a des segfault mais je ne sais pas si ça correspond à ça ou pas:
[164819.764966] calaos_server[517]: segfault at 51 ip 00007fa6297d85d6 sp 00007fffb04e4ae8 error 4 in libc-2.29.so[7fa6296a1000+142000]
[164819.764982] Code: 66 0f ef d1 66 0f 38 17 c2 0f 83 ed 06 00 00 f3 0f 6f 57 cc f3 0f 6f 4e cc b2 cc 66 0f ef d1 66 0f 38 17 c2 0f 83 d2 06 00 00 <f3> 0f 6f 57 dc f3 0f 6f 4e dc b2 dc 66 0f ef d1 66 0f 38 17 c2 0f
[478793.223940] calaos_server[4034]: segfault at 8 ip 00007ff7380b143a sp 00007ffc3e45d3b8 error 4 in libstdc++.so.6.0.25[7ff738091000+ad000]
[478793.223955] Code: 48 83 c7 18 e9 e7 23 fe ff 0f 1f 80 00 00 00 00 48 83 c7 18 e9 17 21 fe ff 0f 1f 80 00 00 00 00 8b 07 85 c0 75 0a 48 8b 47 08 <48> 39 78 08 74 40 48 8b 47 10 48 85 c0 75 0a eb 15 0f 1f 44 00 00
[615311.465903] calaos_server[7483]: segfault at 3c ip 00007f87f685457f sp 00007ffefac589f8 error 6 in libstdc++.so.6.0.25[7f87f683a000+ad000]
[615311.465918] Code: 44 00 00 48 8b 10 48 8b 48 08 48 89 50 08 48 89 08 48 89 d0 48 39 d7 75 ea c3 90 48 8b 46 08 48 89 37 48 89 47 08 48 8b 46 08 <48> 89 38 48 89 7e 08 c3 66 0f 1f 84 00 00 00 00 00 48 8b 07 48 8b

En regardant à l'instant, il y a un uptime de 9 minutes:

root@intel-corei7-64:~# date; systemctl status calaos-server
Mon Jan 4 14:08:16 CET 2021
● calaos-server.service - Calaos home automation server service
Loaded: loaded (/lib/systemd/system/calaos-server.service; enabled; vendor preset: enabled)
Active: active (running) since Mon 2021-01-04 13:58:35 CET; 9min ago
Process: 4810 ExecStartPre=/bin/mkdir -p /home/root/.cache/calaos /etc/calaos (code=exited, status=0/SUCCESS)
Main PID: 4811 (calaos_server)
Tasks: 3 (limit: 4915)
Memory: 11.1M
CGroup: /system.slice/calaos-server.service
├─4811 /usr/bin/calaos_server --config /etc/calaos --cache /home/root/.cache/calaos
└─4813 /usr/bin/calaos_wago --socket /tmp/calaos_proc_08d45529-3ba3-e270-b706-a90eae452050_wago_4811 --namespace wago 192.168.0.1 502

Jan 04 14:08:04 intel-corei7-64 calaos_server[4811]: [CRI] network (HttpClient.cpp:151) Error sending data ! Closing connection.
Jan 04 14:08:04 intel-corei7-64 calaos_server[4811]: [INF] output (IntValue.cpp:122) intern_35: got action, 185
Jan 04 14:08:04 intel-corei7-64 calaos_server[4811]: [CRI] network (HttpClient.cpp:151) Error sending data ! Closing connection.
Jan 04 14:08:06 intel-corei7-64 calaos_server[4811]: [INF] websocket (WebSocket.cpp:446) Received a PONG back in 00:00
Jan 04 14:08:10 intel-corei7-64 calaos_server[4811]: [INF] output (IntValue.cpp:122) intern_33: got action, 4
Jan 04 14:08:10 intel-corei7-64 calaos_server[4811]: [CRI] network (HttpClient.cpp:151) Error sending data ! Closing connection.
Jan 04 14:08:10 intel-corei7-64 calaos_server[4811]: [INF] output (IntValue.cpp:122) intern_34: got action, 0
Jan 04 14:08:10 intel-corei7-64 calaos_server[4811]: [CRI] network (HttpClient.cpp:151) Error sending data ! Closing connection.
Jan 04 14:08:10 intel-corei7-64 calaos_server[4811]: [INF] output (IntValue.cpp:122) intern_35: got action, 175
Jan 04 14:08:10 intel-corei7-64 calaos_server[4811]: [CRI] network (HttpClient.cpp:151) Error sending data ! Closing connection.