Nepravidelně, několikrát za týden, mi vypadne konektivita na IPTV set-top-boxu SledovaniTV. Celé se to tváří, že vypadl internet, v příslušné sekci v nastaveních stb není IP adresa, nic.
Podíval jsem se na log a tam to vypadá následovně:
System log
Sep 22 17:23:01 turris crond[8910]: (root) CMD (/usr/bin/rainbow_button_sync.sh)
Sep 22 19:23:35 turris kernel: [2217047.284185] mv88e6085 f1072004.mdio-mii:10 lan0: Link is Down
Sep 22 19:23:35 turris kernel: [2217047.290823] br-lan: port 1(lan0) entered disabled state
Sep 22 17:23:35 turris netifd: Network device ‘lan0’ link is down
Sep 22 19:23:39 turris kernel: [2217050.728152] mv88e6085 f1072004.mdio-mii:10 lan0: Link is Up - 100Mbps/Full - flow control off
Sep 22 19:23:39 turris kernel: [2217050.736907] br-lan: port 1(lan0) entered blocking state
Sep 22 19:23:39 turris kernel: [2217050.742325] br-lan: port 1(lan0) entered forwarding state
Sep 22 17:23:39 turris netifd: Network device ‘lan0’ link is up
Sep 22 17:24:01 turris crond[8979]: (root) CMD (/usr/bin/rainbow_button_sync.sh)
Sep 22 19:24:15 turris kernel: [2217086.942180] mv88e6085 f1072004.mdio-mii:10 lan0: Link is Down
Sep 22 19:24:15 turris kernel: [2217086.948158] br-lan: port 1(lan0) entered disabled state
Sep 22 17:24:15 turris netifd: Network device ‘lan0’ link is down
Sep 22 19:24:18 turris kernel: [2217090.665717] mv88e6085 f1072004.mdio-mii:10 lan0: Link is Up - 100Mbps/Full - flow control off
Sep 22 19:24:18 turris kernel: [2217090.674490] br-lan: port 1(lan0) entered blocking state
Sep 22 19:24:18 turris kernel: [2217090.679916] br-lan: port 1(lan0) entered forwarding state
Sep 22 17:24:18 turris netifd: Network device ‘lan0’ link is up
Sep 22 19:24:37 turris kernel: [2217109.052310] mv88e6085 f1072004.mdio-mii:10 lan0: Link is Down
Sep 22 19:24:37 turris kernel: [2217109.058302] br-lan: port 1(lan0) entered disabled state
Sep 22 17:24:37 turris netifd: Network device ‘lan0’ link is down
Sep 22 19:24:40 turris kernel: [2217112.025487] mv88e6085 f1072004.mdio-mii:10 lan0: Link is Up - 100Mbps/Full - flow control off
Sep 22 19:24:40 turris kernel: [2217112.034306] br-lan: port 1(lan0) entered blocking state
Sep 22 19:24:40 turris kernel: [2217112.039750] br-lan: port 1(lan0) entered forwarding state
Sep 22 17:24:40 turris netifd: Network device ‘lan0’ link is up
Sep 22 17:24:59 turris netifd: Network device ‘lan0’ link is down
Sep 22 19:24:59 turris kernel: [2217131.674030] mv88e6085 f1072004.mdio-mii:10 lan0: Link is Down
Sep 22 19:24:59 turris kernel: [2217131.680018] br-lan: port 1(lan0) entered disabled state
Sep 22 19:25:01 turris kernel: [2217133.271622] mv88e6085 f1072004.mdio-mii:10 lan0: Link is Up - 100Mbps/Full - flow control off
Sep 22 19:25:01 turris kernel: [2217133.280378] br-lan: port 1(lan0) entered blocking state
Sep 22 19:25:01 turris kernel: [2217133.285796] br-lan: port 1(lan0) entered forwarding state
Sep 22 17:25:01 turris netifd: Network device ‘lan0’ link is up
Sep 22 17:25:01 turris crond[9052]: (root) CMD (/usr/bin/notifier)
Sep 22 17:25:01 turris crond[9053]: (root) CMD (/usr/bin/rainbow_button_sync.sh)
Sep 22 17:25:01 turris crond[9050]: (root) CMDOUT (Working on message: 1600787933-31519)
Sep 22 17:25:01 turris crond[9050]: (root) CMDOUT (Working on message: 1600787935-31868)
Sep 22 17:25:01 turris crond[9050]: (root) CMDOUT (Working on message: 1600787945-31981)
Sep 22 17:25:01 turris crond[9050]: (root) CMDOUT (There is no message to send.)
Sep 22 19:25:02 turris dnsmasq-dhcp[30745]: DHCPDISCOVER(br-lan) fc:d5:d9:4a:af:85
Sep 22 19:25:02 turris dnsmasq-dhcp[30745]: DHCPOFFER(br-lan) 192.168.1.92 fc:d5:d9:4a:af:85
Sep 22 19:25:02 turris dnsmasq-dhcp[30745]: DHCPREQUEST(br-lan) 192.168.1.92 fc:d5:d9:4a:af:85
Sep 22 19:25:02 turris dnsmasq-dhcp[30745]: DHCPACK(br-lan) 192.168.1.92 fc:d5:d9:4a:af:85 iptv
Sep 22 17:25:02 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Sep 22 17:25:02 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Sep 22 17:25:02 turris /dhcp_host_domain_ng.py: DHCP update hostname [iptv,192.168.1.92]
Sep 22 17:25:02 turris /dhcp_host_domain_ng.py: Refresh kresd leases
Divné jsou jiné časy (posunuté o dvě hodiny) a zřejmě selhání DHCP lease. Ten box mám v pevných rezervacích, aby měl stejnou IP adresu - sliboval jsem si od toho, že to bude stabilnější. Není.
toto moze byt zlym kablom, zlym konektorom, alebo chybou jedneho zo zariadeni. Odporucam vymenit kabel pripadne skusit iny port v routeri. A tiez sledovat ine zariadenia ci maju rovnaky problem (idealne v porte lan0)
toto sa riesi, problem vyzera byt v libc kniznici - niektore programy hlasia univerzalny cas, dnsmasq hlasi lokalny.
lease je v poriadku, “hostname check failed” je iny problem, myslel som ze v 5.1.1 uz mal byt vyrieseny.
Kabel už jsem vyměnil, zkusím jiný konektor, ale myslím, že už jsem to v jiném konektoru měl; zkusím znovu. Zkusím do lan0 píchnout NAS a budu to sledovat.
Tím časem ani “jiným problémem” to teda být nemůže, jestli tomu správně rozumím.
Teď mě napadá, že poměrně často (klidně několikrát denně) mi na chvilku vypíná internet i na Wi-Fi, ale nikdy jsem to neřešil, protože za pár sekund je zase všechno v pořádku. Není v Turrisu nějaká chyba, která by mohla kompletně vždycky na chvilku vypnout všechny síťové interfacy?
Nikdy jsem tomu nevěnoval pozornost, začalo to před pár týdny (nebo víc), přesně nevím… na laptopu se to projeví tak, že na chvilku vypadne spojení a zase za pár sekund naskočí, ale ten set-top box to asi občas nerozdejchá.
Všiml jsem si toho, protože jedna z aplikací začala vyhazovat notifikaci “není internet”; ale klidně je možné, že to je nová funkce v té aplikaci a ten set-top box mám asi tři týdny. Takže souvislost se nedá vysledovat.
Vyměnil jsem kabel a zapojil jej do jiné zásuvky na routeru. Teď už to spojení neumírá nafurt, ale výpadky tam jsou pořád. Protože to začalo dělat relativně nedávno, myslím, že jde o nějakou softwarovou chybu routeru.
IPTV box jsem reklamoval a bude vyměněn. Ale ty chvilkové výpadky se projevují i na PC, akorát tam je to otázka pár sekund a ničemu to de facto nevadí, proto jsem tomu dosud nevěnoval pozornost.
BTW, @viktor - i podle logu z prvního postu by to mohlo být v IPTV boxu?
Může to být kombinovaný problém DHCP serveru a klienta. Mě podobně začala zlobit TV od Samsungu a nemyslím si, že by se rozbil hardware. Protože se mi to ale s jinými zařízeními nestává, tipuji, že klient v televizi (historicky neměnný) má nějaký problém s aktuální verzí serveru, který se zase může specificky chovat v některých případech. Zkoušel jsem i odebrat TV z rezervací a nechat dynamické přidělování a několik dalších věcí, ale bezúspěšně. Dočasně to řeším odpojením a připojením kabelu, což pomáhá, ale zábavné to není.
U mně bohužel odpojení a připojení kabelu nepomohlo, ale v nové síťové zásuvce jsem to ještě nezkoušel, myslím. Vždycky mi pomohlo rebootovat settop box, ale to trvá a je to pruda
Ještě mi podpora poradila odhlásit se z beta programu (nedošlo mi, že to ovlivňuje i klienta na settop boxu) a jedu na oficiální verzi aplikace, s novým patch kabelem a v jiné zásuvce
Po výměně set-top boxu se to už jednou stalo zase. Upřímně, tím pádem to pokládám za chybu Turrisu. Jestli je možné to nějak nahlásit, nahlásím, a jinak budu doufat, že to nakonec opraví.
Summary
Oct 15 16:29:17 turris hostapd: wlan0: STA a4:02:b9:46:7f:30 IEEE 802.11: authenticated
Oct 15 16:29:17 turris hostapd: wlan0: STA a4:02:b9:46:7f:30 IEEE 802.11: associated (aid 4)
Oct 15 16:29:17 turris hostapd: wlan0: AP-STA-CONNECTED a4:02:b9:46:7f:30
Oct 15 16:29:17 turris hostapd: wlan0: STA a4:02:b9:46:7f:30 RADIUS: starting accounting session 068D010C9D4C7A69
Oct 15 16:29:17 turris hostapd: wlan0: STA a4:02:b9:46:7f:30 WPA: pairwise key handshake completed (RSN)
Oct 15 18:29:17 turris dnsmasq-dhcp[6320]: DHCPREQUEST(br-lan) 192.168.1.190 a4:02:b9:46:7f:30
Oct 15 18:29:17 turris dnsmasq-dhcp[6320]: DHCPACK(br-lan) 192.168.1.190 a4:02:b9:46:7f:30 DESKTOP-5KIODBN
Oct 15 18:29:17 turris dnsmasq-dhcp[6320]: read /etc/ethers - 0 addresses
Oct 15 16:29:17 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:17 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:17 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:17 turris /dhcp_host_domain_ng.py: DHCP update hostname [DESKTOP-5KIODBN,192.168.1.190]
Oct 15 16:29:17 turris /dhcp_host_domain_ng.py: Refresh kresd leases
Oct 15 16:29:17 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:17 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:17 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:17 turris /dhcp_host_domain_ng.py: DHCP update hostname [qnap,192.168.1.90]
Oct 15 16:29:17 turris /dhcp_host_domain_ng.py: Refresh kresd leases
Oct 15 16:29:18 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:18 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:18 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:18 turris /dhcp_host_domain_ng.py: DHCP update hostname [DESKTOP-5KIODBN,192.168.1.190]
Oct 15 16:29:18 turris /dhcp_host_domain_ng.py: Refresh kresd leases
Oct 15 16:29:18 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:18 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:18 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:18 turris /dhcp_host_domain_ng.py: Refresh kresd leases
Oct 15 16:29:18 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:18 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:18 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:18 turris /dhcp_host_domain_ng.py: DHCP update hostname [thinkpad-e330,192.168.1.125]
Oct 15 16:29:18 turris /dhcp_host_domain_ng.py: Refresh kresd leases
Oct 15 16:29:19 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:19 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:19 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:19 turris /dhcp_host_domain_ng.py: DHCP update hostname [WL356358,192.168.1.117]
Oct 15 16:29:19 turris /dhcp_host_domain_ng.py: Refresh kresd leases
Oct 15 18:29:19 turris dnsmasq-dhcp[6320]: read /etc/ethers - 0 addresses
Oct 15 16:29:19 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:19 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:19 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:19 turris /dhcp_host_domain_ng.py: Refresh kresd leases
Oct 15 16:29:19 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:19 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:19 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:19 turris /dhcp_host_domain_ng.py: Refresh kresd leases
Oct 15 16:29:19 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:19 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:19 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:19 turris /dhcp_host_domain_ng.py: DHCP update hostname [qnap,192.168.1.90]
Oct 15 16:29:19 turris /dhcp_host_domain_ng.py: Refresh kresd leases
Oct 15 16:29:20 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:20 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:20 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:20 turris /dhcp_host_domain_ng.py: DHCP update hostname [DESKTOP-5KIODBN,192.168.1.190]
Oct 15 16:29:20 turris /dhcp_host_domain_ng.py: Refresh kresd leases
Oct 15 16:29:20 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:20 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:20 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:20 turris /dhcp_host_domain_ng.py: Refresh kresd leases
Oct 15 16:29:20 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:20 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:20 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:20 turris /dhcp_host_domain_ng.py: DHCP update hostname [thinkpad-e330,192.168.1.125]
Oct 15 16:29:20 turris /dhcp_host_domain_ng.py: Refresh kresd leases
Oct 15 16:29:20 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:20 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:20 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:20 turris /dhcp_host_domain_ng.py: DHCP update hostname [WL356358,192.168.1.117]
Oct 15 16:29:20 turris /dhcp_host_domain_ng.py: Refresh kresd leases
Oct 15 16:29:21 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:21 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:21 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:21 turris /dhcp_host_domain_ng.py: Refresh kresd leases
Oct 15 16:29:21 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:21 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:21 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:21 turris /dhcp_host_domain_ng.py: Refresh kresd leases
Oct 15 18:29:22 turris kernel: [572308.969684] mv88e6085 f1072004.mdio-mii:10 lan1: Link is Down
Oct 15 18:29:22 turris kernel: [572308.975589] br-lan: port 2(lan1) entered disabled state
Oct 15 16:29:22 turris netifd: Network device ‘lan1’ link is down
Oct 15 18:29:25 turris kernel: [572312.019771] mv88e6085 f1072004.mdio-mii:10 lan1: Link is Up - 100Mbps/Full - flow control off
Oct 15 18:29:25 turris kernel: [572312.028432] br-lan: port 2(lan1) entered blocking state
Oct 15 18:29:25 turris kernel: [572312.033772] br-lan: port 2(lan1) entered forwarding state
Oct 15 16:29:25 turris netifd: Network device ‘lan1’ link is up
Oct 15 16:29:45 turris netifd: Network device ‘lan1’ link is down
Oct 15 18:29:45 turris kernel: [572331.733096] mv88e6085 f1072004.mdio-mii:10 lan1: Link is Down
Oct 15 18:29:45 turris kernel: [572331.739078] br-lan: port 2(lan1) entered disabled state
Oct 15 18:29:46 turris kernel: [572333.390398] mv88e6085 f1072004.mdio-mii:10 lan1: Link is Up - 100Mbps/Full - flow control off
Oct 15 18:29:46 turris kernel: [572333.399088] br-lan: port 2(lan1) entered blocking state
Oct 15 18:29:46 turris kernel: [572333.404427] br-lan: port 2(lan1) entered forwarding state
Oct 15 16:29:46 turris netifd: Network device ‘lan1’ link is up
Oct 15 18:29:47 turris dnsmasq-dhcp[6320]: DHCPDISCOVER(br-lan) fc:d5:d9:4a:ae:16
Oct 15 18:29:47 turris dnsmasq-dhcp[6320]: DHCPOFFER(br-lan) 192.168.1.188 fc:d5:d9:4a:ae:16
Oct 15 18:29:47 turris dnsmasq-dhcp[6320]: DHCPREQUEST(br-lan) 192.168.1.188 fc:d5:d9:4a:ae:16
Oct 15 18:29:47 turris dnsmasq-dhcp[6320]: DHCPACK(br-lan) 192.168.1.188 fc:d5:d9:4a:ae:16
Oct 15 16:29:47 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:47 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:47 turris /dhcp_host_domain_ng.py: Add_lease, hostname check failed
Oct 15 16:29:47 turris /dhcp_host_domain_ng.py: Refresh kresd leases
Oct 15 16:30:01 turris crond[15221]: (root) CMD (/usr/bin/rainbow_button_sync.sh)
Oct 15 16:30:01 turris crond[15220]: (root) CMD (/usr/bin/notifier)
Oct 15 16:30:01 turris crond[15222]: (root) CMD (/bin/sh -c “source /lib/functions/sentinel.sh; allowed_to_run “nikola” && exec sentinel-nikola --random-sleep”)
Oct 15 16:30:01 turris crond[15223]: (root) CMD (/usr/bin/get-api-crl)
Oct 15 16:30:01 turris crond[15219]: (root) CMDOUT (Not agreed with EULA.)
Oct 15 16:30:01 turris crond[15219]: (root) CMDOUT ()
Oct 15 16:30:01 turris crond[15219]: (root) CMDOUT (EULA could be found at /usr/share/sentinel-eula/ and you can)
Oct 15 16:30:01 turris crond[15219]: (root) CMDOUT (agree with it either in ReForis data collect tab or using)
Oct 15 16:30:01 turris crond[15219]: (root) CMDOUT (uci config:)
Oct 15 16:30:01 turris crond[15219]: (root) CMDOUT (uci set sentinel.main.agreed_with_eula_version=1 && uci commit)
Oct 15 16:30:01 turris crond[15219]: (root) CMDOUT ()
Oct 15 16:30:01 turris crond[15219]: (root) CMDOUT (EULA version may increase in time. See documentation for more details.)
Oct 15 16:30:01 turris crond[15217]: (root) CMDOUT (Working on message: 1602684293-26155)
Oct 15 16:30:01 turris crond[15217]: (root) CMDOUT (There is no message to send.)
