Dotaz: syslog je plný tohto: dhcpcd[365]: received SIGPIPE

[hal_sk]

Ahoj, Na mojom Raspberry Pi mám nainštalovaný openhabian (funguje ako server pre iOT) a na internet som pripojený cez USB GSM modem pomocou jedného skriptu - ktorý som nastavil aby sa spúšťal vždy po reboote systému. Poslednú dobu však z neznámeho dôvodu približne medzi 00:30 a 06:00 (ráno) stratím pripojenie na internet. Vidím to v logoch, lebo som nastavil logovanie stavu offline/online a tiež som nastavil skript aby sa R-Pi každú pol-hodinu reštartoval ak je systém offline. Pozrel som sa na /var/log/syslog a ten súbor narástol na cca 250 MB. Ani mi nešli otvoriť posledné riadky, ale tie ktoré išli otvoriť boli z času okolo 6 ráno a všetky riadky obsahovali "dhcpcd[365]: received SIGPIPE". Takýchto riadkov sú tam milióny, idú asi v nekonečnej slučke, lebo na každú sekundu sú tam stovky týchto riadkov. Viete v čom môže byť problém? Som Linux začiatočník. Mám podozrenie na ovládače od modemu, alebo skript ktorý ho pripája na net.

Odpovědi

[X]

Nekde jsi vyrobil smycku, ktera se pousti porad dokola. SIGPIPE je rozbita roura.

Vidím to v logoch, lebo som nastavil logovanie stavu offline/online a tiež som nastavil skript aby sa R-Pi každú pol-hodinu reštartoval ak je systém offline.

To restartovani celeho RPi je zbytecne, staci pokud je to opravdu nutne restartovat sit, nebo jen DHCP, ale idealni by bylo zjistit pricinu. Mohl by jsi detailne popsat "som nastavil logovanie" a taky by se hodil ten " som nastavil skript" skript.

[hal_sk]

Tu je skript no-internet-reboot.sh, ktorý spúšťam cez crontab každú pol hodinu */30 * * * * /usr/local/bin/no-internet-reboot.sh. Skript pinguje vybrané IP adresy a v prípade že nie je odozva zapisuje o tom log a reštartuje PC.

#!/bin/bash

# internet connection check based on pinging public dns ip(s)

IPtoCheck=("208.67.222.222" "208.67.220.220" "1.1.1.1" "1.0.0.1" "9.9.9.9" "149.112.112.112")
countOnline=0
for ip in "${IPtoCheck[@]}"
do
  sleep 10
  if ping -q -c 1 -W 1 $ip >/dev/null
    then
    echo "$ip is online"
    countOnline=$((countOnline+1))
    else
    echo "$ip is offline"
  fi
done

if [ $countOnline -gt 0 ]
  then
  echo "we are probably online"
  else
  echo "we are probably offline"
  # we are probably offline - need to reboot and hope modem will reconnect after reboot
  echo "rebooting..."
  sleep 60
  echo $(date)" >> "$(realpath  $0)" >> no internet connection (rebooting now)" >> /home/openhabian/logs
  sudo reboot
fi

Tu je skript modem-autoconnect.sh, ktorý spúšťam cez systemd vždy pri štarte PC. V skripte som cenzuroval môj PIN pre SIM kartu v modeme, inak je skript ako originál.

#!/bin/bash

echo $(date)" >> "$(realpath  $0)" >> modem autoconnect starts" /home/openhabian/logs

# if I do not use this delay - it sometimes does not work
sleep 5

# unlocking the SIM card with PIN
sudo mbimcli -d /dev/cdc-wdm0 -p --enter-pin=****

# if I do not use this delay - it sometimes does not work
sleep 3

# connecting the modem to the internet
sudo mbim-network /dev/cdc-wdm0 start

Tu je uvítacie info ktoré vidím po pripojení sa do terminálu cez SSH (zvýraznil som "podozrivé" riadky).

###############################################################################
###############  openhabian  ##################################################
###############################################################################
##        Ip = Unable to parse ip . Please debug.
##   Release = Raspbian GNU/Linux 11 (bullseye)
##    Kernel = Linux 5.10.63-v7l+
##  Platform = none
##    Uptime = 0 day(s). 9:13:42
## CPU Usage = 1.01% avg over 4 cpu(s) (4 core(s) x 1 socket(s))
##  CPU Load = 1m: 0.24, 5m: 0.10, 15m: 0.05
##    Memory = Free: 0.45GB (24%), Used: 1.42GB (76%), Total: 1.87GB
##      Swap = Free: 2.43GB (100%), Used: 0.00GB (0%), Total: 2.43GB
##      Root = Free: 8.39GB (61%), Used: 5.31GB (39%), Total: 14.33GB
##   Updates = 14 apt updates available.
##  Sessions = 1 session(s)
## Processes = 145 running processes of 32768 maximum processes
###############################################################################

                          _   _     _     ____   _               
  ___   ___   ___   ___  | | | |   / \   | __ ) (_)  ____   ___  
 / _ \ / _ \ / _ \ / _ \ | |_| |  / _ \  |  _ \ | | / _  \ / _ \ 
| (_) | (_) |  __/| | | ||  _  | / ___ \ | |_) )| || (_) || | | |
 \___/|  __/ \___/|_| |_||_| |_|/_/   \_\|____/ |_| \__|_||_| | |
      |_|                  openHAB 3.1.0 - Release Build     

[j]

Hele, tux nejsou widle, vazne nepotrebujes delat reboot kdyz ti uhnije sit.

Jednak to co pouzivas, ma mimo jiny parametr status - coz je to prvni, na co by ses mel podivat, kdyz to uhnije. A druhak to ma taky stop, takze ti staci vypnout a zapnout ten modem. V horsim pripade se da cokoli na USBcku proste odpojit od napajeni a znova pripojit.

Pricemz pokud uhnivani site je "normalni" stav, tak je nejvyssi cas to vymenit ze neco co neuhniva.

Pro zajimavost, kdyz na to sahnes (za provozu na ten dongl/malinu), jakou to ma teplotu? Jestli na tom stezi udrzis ruku = vic nez 60 = sezen si aspon vetrak (velkej, 120+) a nech ho na to foukat.

BTW: Ze prej ten systemd shit umi zjistit, estli neco bezi nebo ne, a sam to restartnout ... sem slysel nekde ...

---

Dete s tim guuglem dopice!

[j]

A neda mi ... normalni funkcni logger ti zaloguje tu hlasku jednou, a pak ti tam pripise, ze stejna nasledovala jeste tisickrat, takze ti nevyrabi GB logu vohovne.

---

Dete s tim guuglem dopice!

[j]

Nikolivek, SIGPIPE je rozbitej(neexistujici) socket. Hlasa mu to dhcp klient.

Mno a ten socket muze zmizet zrovna trebas proto, ze uhnije ten usb dongl. A nebo taky proto, ze ta jebka systemd se rozhodne, ze dotycna vec neni aktualne potreba. Coz by i odpovidalo tem nocnim hodinam.

---

Dete stim guuglem dopice!

[hal_sk]

To Raspberry mám oblečené vo veľkom pasívnom chladiči a je umiestnené do garáže kde je teraz riadna kosa. USB modem je teplý, ale dá sa na ňom udržať ruka v pohode. Teraz som zistil, že keď sa v syslogu necyklia SIGPIPE errore (typicky keď už prestane fungovať internet), tak sa tam cyklí nasledovný segment riadkov, ktorý nejako súvisí s "comitup-web" čo neviem čo je...

Dec  9 14:23:25 openhabian systemd[1]: comitup-web.service: Main process exited, code=exited, status=1/FAILURE
Dec  9 14:23:25 openhabian systemd[1]: comitup-web.service: Failed with result 'exit-code'.
Dec  9 14:23:31 openhabian systemd[1]: comitup-web.service: Scheduled restart job, restart counter is at 1422.
Dec  9 14:23:31 openhabian systemd[1]: Stopped Comitup Web Service.
Dec  9 14:23:31 openhabian systemd[1]: Started Comitup Web Service.
Dec  9 14:23:31 openhabian comitup-web[21589]: Traceback (most recent call last):
Dec  9 14:23:31 openhabian comitup-web[21589]:   File "/usr/sbin/comitup-web", line 11
Dec  9 14:23:31 openhabian comitup-web[21589]:     load_entry_point('comitup==1.31', 'console_scripts', 'comitup-web')()
Dec  9 14:23:31 openhabian comitup-web[21589]:   File "/usr/share/comitup/web/comitupweb.py", line 171, in main
Dec  9 14:23:31 openhabian comitup-web[21589]:     ciu_client.ciu_points()
Dec  9 14:23:31 openhabian comitup-web[21589]:   File "/usr/lib/python3/dist-packages/dbus/proxies.py", line 141, in __call__
Dec  9 14:23:31 openhabian comitup-web[21589]:     return self._connection.call_blocking(self._named_service,
Dec  9 14:23:31 openhabian comitup-web[21589]:   File "/usr/lib/python3/dist-packages/dbus/connection.py", line 652, in call_blocking
Dec  9 14:23:31 openhabian comitup-web[21589]:     reply_message = self.send_message_with_reply_and_block(
Dec  9 14:23:31 openhabian comitup-web[21589]: dbus.exceptions.DBusException: org.freedesktop.DBus.Python.BrokenPipeError: Traceback (most recent call last):
Dec  9 14:23:31 openhabian comitup-web[21589]:   File "/usr/lib/python3/dist-packages/dbus/service.py", line 711, in _message_cb
Dec  9 14:23:31 openhabian comitup-web[21589]:     retval = candidate_method(self, *args, **keywords)
Dec  9 14:23:31 openhabian comitup-web[21589]:   File "/usr/share/comitup/comitup/statemgr.py", line 71, in access_points
Dec  9 14:23:31 openhabian comitup-web[21589]:     aps = iwscan.candidates()
Dec  9 14:23:31 openhabian comitup-web[21589]:   File "/usr/share/comitup/comitup/iwscan.py", line 106, in candidates
Dec  9 14:23:31 openhabian comitup-web[21589]:     p.start()
Dec  9 14:23:31 openhabian comitup-web[21589]:   File "/usr/lib/python3.9/multiprocessing/process.py", line 121, in start
Dec  9 14:23:31 openhabian comitup-web[21589]:     self._popen = self._Popen(self)
Dec  9 14:23:31 openhabian comitup-web[21589]:   File "/usr/lib/python3.9/multiprocessing/context.py", line 224, in _Popen
Dec  9 14:23:31 openhabian comitup-web[21589]:     return _default_context.get_context().Process._Popen(process_obj)
Dec  9 14:23:31 openhabian comitup-web[21589]:   File "/usr/lib/python3.9/multiprocessing/context.py", line 277, in _Popen
Dec  9 14:23:31 openhabian comitup-web[21589]:     return Popen(process_obj)
Dec  9 14:23:31 openhabian comitup-web[21589]:   File "/usr/lib/python3.9/multiprocessing/popen_fork.py", line 16, in __init__
Dec  9 14:23:31 openhabian comitup-web[21589]:     util._flush_std_streams()
Dec  9 14:23:31 openhabian comitup-web[21589]:   File "/usr/lib/python3.9/multiprocessing/util.py", line 435, in _flush_std_streams
Dec  9 14:23:31 openhabian comitup-web[21589]:     sys.stdout.flush()
Dec  9 14:23:31 openhabian comitup-web[21589]: BrokenPipeError: [Errno 32] Broken pipe

[hal_sk]

Tak som vypol "comitup-web.service". Linux zatiaľ nespadol a logy prestali pribúdať. Uvidím, či ma to v noci znova neodpojí z internetu. Ak nie, tak tento service to asi spôsoboval. Vraj je to nejaká služba súvisiaca s wifi. To je neskôr budem potrebovať bluetooth, tak dúfam, že to neovplyvní.

[X]

Ten "comitup-web" je captive portal pro wifi, ktery ve sklepe urcite nepotrebujes. Buh vi kolik dalsich zbytecnych veci na tom vlastne bezi a vytezuje souborovy system a system samotny. Do budoucna bych doporucil cisty minimalni raspbian. Je to pracnesi na uvodni nastaveni, ale hlavne obsahuje jwn nutne minimum. Vyhnes se tak presme temto problemum.

[hal_sk]

Příloha:

• Screenshot at 2021-12-10 10-27-21.png (9552 bytů)

Takže znova sa to odpojilo od internetu v čase medzi 00:30 a 06:00. Rovnaké zacyklené SIGPIPE logy to ukazuje - viď príloha. Skúšal som vypnúť wifi cez "nmcli radio wifi off". Ale zdá sa, že to je len softvérové vypnutie, lebo ukazuje potom:

WIFI-HW  WIFI      WWAN-HW  WWAN    
enabled  disabled  enabled  enable

Najradšej by som len nejako zablokoval len ten proces "dhcpcd" ktorý hlási SIGPIPE logy. Lebo ja potrebujem bluetooth a predpokladám, že ak sa mi aj podarí vypnúť wifi hardwerovo, tak prídem o bluetooth (?).

[hal_sk]

PS: oprava - tentoraz bol R-Pi od internetu odpojený aj po 06:00 (než je bežné), lebo som ten skript na kontrolu stavu internetu prerobil ako bolo odporučené: teda som namiesto núteného reebotu pri offline stave som nastavil len znovu pripojenie modemu. Asi to nezafungovalo. Musel som prísť do garáže to R-Pi reštartovať manuálne. Potom sa internet znova chytil. Toto R-Pi spravujem to cez SSH vzdialene.

[j]

Dhcpcd je jak sem psal vejs dhcp klient, to je to, co ti od ISP prideli IPcko. Pokud ho vypnes, tak zadny nedostanes.

Loguje ti proto, ze iface, na kterym se snazi to IPcko ziskat zmizel nebo je nedostupnej, tak to zkousi porad dokola. Mrkni se co to loguje kdyz to funguje a uvidis tam, ze si cas od casu rekne o obnoveni pridelu.

Tudiz tohle logovani vubec neres, tebe (a nas) zajima, co je tesne pred tim, nez se to od netu odpoji. Nevim jak co funguje v ty veci co pouzivas, ale chtelo by to neco jako dmesg -e. Tam bys mel videt jestli nezmizel nejakej HW nebo nedoslo k nejaky HW chybe a pripadne kdy.

Tady mas neco na tema jak USB vec odpojit a pripojit.

https://loginroot.com/power-off-and-on-usb-device-in-linux-ubuntu/

---

Dete s tim guuglem dopice!

[hal_sk]

Díky za tip. Ale neviem sa pozrieť do histórie logov "dmesg -e". Ukazuje mi logy len od posledného reštartu (cca od 9:20 dnes). Ale nechal som bežať skript, ktorý by tie logy mal zaznamenať (pomocou "dmesg -e -w") v priebehu noci, tak zajtra ráno uvidím, či z toho niečo bude.

[Peter Golis]

A nie je to len nejaký denný limit na internet, čo poskytovateľ zhadzuje v čase hlbokého spánku bežnej vzorky populácie?

Podobne sa kedysi v drevených dobách riešili hlasové hovory, aby človek neprevolal výplatu ak zabudol ukončiť hovor.

[hal_sk]

Je to program "Dáta 1 €" od Orange. Časové obmedzenia tam nie sú. Len rýchlostné po prečerpaní 100 MB na mesiac (tento limit mám prečerpaný takmer stále, ale pomalá rýchlosť na iOT a SSH správu stačí - ak to nie je zdrojom týchto problémov).

[j]

To ale neznamena, ze te ve 3 rano neodstrelej ... ;D.

Pokud to nemas koupeny jako pevny pripojeni tak bych to dokonce predpokladal.

---

Dete s tim guuglem dopice!

[hal_sk]

Příloha:

• r-pi-modem.png (34557 bytů)

Ten "dmesg -e" som nechal cez noc pravidelne logovať. Výstupy toho príkazu boli vždy rovnaké pred/počas/po pravidelnej rannej "epizódy". Nepribudli tam žiadne nové hlásenia. Pripájam screenshot výstupu "nmcli". Je to divné, že R-Pi vidí môj modem ako "disconnected". Toto Pi pristupuje na internet len cez modem.

[hal_sk]

Zabudol som podotknúť, že screenshot bol robený v čase, kedy bolo Pi určite do internetu pripojené (spravujem to cez SSH tunel).

[hal_sk]

Vraj na mojom distre beží služba "FireMotD" ktorá má v čase 0:00:00 and 5:59:59 zbierať nejaké dáta vrátane sieťových. Skúsim službu pozastaviť a uvidím čo sa stane.