Router kommt nicht wieder online. debugging trotzdem möglich :)
Hallo Leute, heute morgen wollte ein Kabelmeshrouter nach automatischem Reboot nicht wieder online kommen, aber ich konnte noch per link-local rauf und habe mal ein wenig herumprobiert. Noch ist er nicht wieder online, aber ich dachte mir, die Ausgaben könnten fürs Firmware-debugging interessant sein. Deshalb hier: ---------------------------8<--------------------------- root@FF-Bad-Iburg-Pfarrheim-Glane-01:~# hoodselector No VPN connection found Testing neighboring adhoc networks for batman advanced gw connection. The following wireless networks have been found: 73 2437 02:00:0a:12:58:00 mesh.ffnw After filtering we will test the following wireless networks: No neighboring freifunk batman advanced mesh found. Command failed: Request timed out Failed to parse json data: unexpected end of data currend configuration are not defined as hood VPN stopped. Command failed: Request timed out Command failed: Request timed out Command failed: Request timed out Wireless restarted. IBSS needed reconfiguration. Applied new settings and restarted. Command failed: Request timed out Command failed: Request timed out Command failed: Request timed out Wireless restarted. MESH needed reconfiguration. Applied new settings and restarted. Fastd needed reconfiguration. Stopped and applied new settings. VPN enable. VPN started. Interface br-client restarted. VPN needed reconfiguration. Applied new settings and restarted. Set hood "default" Set defaulthood. Command failed: Request timed out Failed to parse json data: unexpected end of data Command failed: Request timed out /usr/bin/lua: /usr/sbin/hoodselector:132: attempt to index local 'e' (a nil value) stack traceback: /usr/sbin/hoodselector:132: in function 'r' /usr/sbin/hoodselector:205: in function 'h' /usr/sbin/hoodselector:938: in main chunk [C]: ? --------------------------->8--------------------------- im logread steht nur alle paar Minuten: ---------------------------8<--------------------------- Thu Aug 3 16:42:24 2017 kern.emerg kernel: [23206.120000] unregister_netdevice: waiting for bat0 to become free. Usage count = 4 Thu Aug 3 16:42:24 2017 kern.emerg kernel: [23206.380000] unregister_netdevice: waiting for primary0 to become free. Usage count = 1 Thu Aug 3 16:42:24 2017 kern.emerg kernel: [23206.640000] unregister_netdevice: waiting for local-node to become free. Usage count = 1 --------------------------->8--------------------------- die systemzeit ist offensichtlich falsch, aber das liegt sicherlich an der Nichterreichbarkeit jeglicher ntp-server. Ich werde ihn bis 18 Uhr erstmal nicht rebooten, sondern warten, ob jemand eine Idee hat, welche Ausgaben außerdem aufschlussreich sein könnten. Die /tmp/hoodselector_error war übrigens leer LG Lorenz
Hi Lorenz,
heute morgen wollte ein Kabelmeshrouter nach automatischem Reboot nicht wieder online kommen, aber ich konnte noch per link-local rauf und habe mal ein wenig herumprobiert. Noch ist er nicht wieder online, aber ich dachte mir, die Ausgaben könnten fürs Firmware-debugging interessant sein. Deshalb hier:
Abermals danke für diese wirklich hilfreichen Informationen.
---------------------------8<--------------------------- root@FF-Bad-Iburg-Pfarrheim-Glane-01:~# hoodselector No VPN connection found Testing neighboring adhoc networks for batman advanced gw connection. The following wireless networks have been found: 73 2437 02:00:0a:12:58:00 mesh.ffnw After filtering we will test the following wireless networks: No neighboring freifunk batman advanced mesh found. Command failed: Request timed out Failed to parse json data: unexpected end of data currend configuration are not defined as hood VPN stopped. Command failed: Request timed out Command failed: Request timed out Command failed: Request timed out Wireless restarted. IBSS needed reconfiguration. Applied new settings and restarted. Command failed: Request timed out Command failed: Request timed out Command failed: Request timed out Wireless restarted. MESH needed reconfiguration. Applied new settings and restarted. Fastd needed reconfiguration. Stopped and applied new settings. VPN enable. VPN started. Interface br-client restarted. VPN needed reconfiguration. Applied new settings and restarted. Set hood "default" Set defaulthood. Command failed: Request timed out Failed to parse json data: unexpected end of dataLorenz Command failed: Request timed out /usr/bin/lua: /usr/sbin/hoodselector:132: attempt to index local 'e' (a nil value) stack traceback: /usr/sbin/hoodselector:132: in function 'r' /usr/sbin/hoodselector:205: in function 'h' /usr/sbin/hoodselector:938: in main chunk [C]: ? --------------------------->8---------------------------
Die "Request timed out" könnten durch das 11s Netzwerk entstehen. den nil Index untersuche ich.
im logread steht nur alle paar Minuten:
---------------------------8<--------------------------- Thu Aug 3 16:42:24 2017 kern.emerg kernel: [23206.120000] unregister_netdevice: waiting for bat0 to become free. Usage count = 4 Thu Aug 3 16:42:24 2017 kern.emerg kernel: [23206.380000] unregister_netdevice: waiting for primary0 to become free. Usage count = 1 Thu Aug 3 16:42:24 2017 kern.emerg kernel: [23206.640000] unregister_netdevice: waiting for local-node to become free. Usage count = 1 --------------------------->8---------------------------
Kannst du noch die ausgaben von ifconfig, iwinfo und cat /etc/config/wireless hier Posten? Die helfen mir den zustand des Routers einzuschätzen.
die systemzeit ist offensichtlich falsch, aber das liegt sicherlich an der Nichterreichbarkeit jeglicher ntp-server. Ich werde ihn bis 18 Uhr erstmal nicht rebooten, sondern warten, ob jemand eine Idee hat, welche Ausgaben außerdem aufschlussreich sein könnten. Die /tmp/hoodselector_error war übrigens leer
Jo die Systemzeit ist abhängig von der Netzwerk Verbindung wie du es ja schon gesagt hast. Das die /tmp/hoodselector_error leer ist kann ich mir nur dadurch erklären das der hoodselector garnicht via cron läuft. evtl. ist der Router beim booten irgendwo hängen geblieben so das der cron daemon noch garnicht aktiv ist. Ich hab gerade nicht den passenden befehl parat um zu prüfen ob der daemon läuft versuch mal /etc/init.d/cron status oder /etc/init.d/micron status oder so ähnlich. Schöne Grüße Tarek
leider wurde die Kiste wahrscheinlich mittlerweile powercycled; die uptime ist ca 3,5 Std und weder Thomas noch ich haben ihn rebooted. Beim nächsten live-debugging-kandidaten tue ich die mir bekannten keys drauf, damit es nicht an meiner zeitlichen Verfügbarkeit hängt. mesh_radio0 -- also 802.11s -- ist dort schon seit längerem (vor etliche reboots) deakiviert worden. kann es trotzdem Probleme machen? Auch wenn es jetzt vermutlich uninteressant ist, hier die gewünschten infos: root@FF-Bad-Iburg-Pfarrheim-Glane-01:~# ifconfig bat0 Link encap:Ethernet HWaddr 10:FE:ED:C2:41:68 inet6 addr: fe80::12fe:edff:fec2:4168/64 Scope:Link UP BROADCAST RUNNING MULTICAST MTU:1500 Metric:1 RX packets:497090 errors:0 dropped:0 overruns:0 frame:0 TX packets:61066 errors:0 dropped:60 overruns:0 carrier:0 collisions:0 txqueuelen:0 RX bytes:82541874 (78.7 MiB) TX bytes:23306248 (22.2 MiB) br-client Link encap:Ethernet HWaddr 10:FE:ED:C2:41:68 inet6 addr: fd74:fdaa:9dc4:5800:12fe:edff:fec2:4168/64 Scope:Global inet6 addr: 2a06:e881:2000:4000:12fe:edff:fec2:4168/64 Scope:Global inet6 addr: fe80::12fe:edff:fec2:4168/64 Scope:Link inet6 addr: fd74:fdaa:9dc4:0:12fe:edff:fec2:4168/64 Scope:Global UP BROADCAST RUNNING MULTICAST MTU:1500 Metric:1 RX packets:536517 errors:0 dropped:17 overruns:0 frame:0 TX packets:35174 errors:0 dropped:0 overruns:0 carrier:0 collisions:0 txqueuelen:0 RX bytes:91876261 (87.6 MiB) TX bytes:8905516 (8.4 MiB) br-mesh_lan Link encap:Ethernet HWaddr DE:4A:0C:F6:6F:8C inet6 addr: fe80::dc4a:cff:fef6:6f8c/64 Scope:Link UP BROADCAST RUNNING MULTICAST MTU:1500 Metric:1 RX packets:717955 errors:0 dropped:209 overruns:0 frame:0 TX packets:177185 errors:0 dropped:0 overruns:0 carrier:0 collisions:0 txqueuelen:0 RX bytes:123041923 (117.3 MiB) TX bytes:44078065 (42.0 MiB) br-wan Link encap:Ethernet HWaddr DE:4A:0C:F6:6F:88 inet6 addr: fe80::dc4a:cff:fef6:6f88/64 Scope:Link UP BROADCAST RUNNING MULTICAST MTU:1500 Metric:1 RX packets:0 errors:0 dropped:0 overruns:0 frame:0 TX packets:541393 errors:0 dropped:0 overruns:0 carrier:0 collisions:0 txqueuelen:0 RX bytes:0 (0.0 B) TX bytes:66456780 (63.3 MiB) client0 Link encap:Ethernet HWaddr DE:4A:0C:F6:6F:88 inet6 addr: fe80::dc4a:cff:fef6:6f88/64 Scope:Link UP BROADCAST RUNNING MULTICAST MTU:1500 Metric:1 RX packets:0 errors:0 dropped:0 overruns:0 frame:0 TX packets:3329 errors:0 dropped:0 overruns:0 carrier:0 collisions:0 txqueuelen:1000 RX bytes:0 (0.0 B) TX bytes:257720 (251.6 KiB) eth0 Link encap:Ethernet HWaddr 10:FE:ED:C2:41:69 UP BROADCAST RUNNING MULTICAST MTU:1500 Metric:1 RX packets:0 errors:0 dropped:0 overruns:0 frame:0 TX packets:541390 errors:0 dropped:0 overruns:0 carrier:0 collisions:0 txqueuelen:1000 RX bytes:0 (0.0 B) TX bytes:66456482 (63.3 MiB) Interrupt:4 eth1 Link encap:Ethernet HWaddr 10:FE:ED:C2:41:68 UP BROADCAST RUNNING MULTICAST MTU:1500 Metric:1 RX packets:718104 errors:0 dropped:144 overruns:0 frame:0 TX packets:177192 errors:0 dropped:0 overruns:0 carrier:0 collisions:0 txqueuelen:1000 RX bytes:133109942 (126.9 MiB) TX bytes:44079616 (42.0 MiB) Interrupt:5 ibss0 Link encap:Ethernet HWaddr DE:4A:0C:F6:6F:8A inet6 addr: fe80::dc4a:cff:fef6:6f8a/64 Scope:Link UP BROADCAST RUNNING MULTICAST MTU:1532 Metric:1 RX packets:359406 errors:0 dropped:78 overruns:0 frame:0 TX packets:94018 errors:0 dropped:0 overruns:0 carrier:0 collisions:0 txqueuelen:1000 RX bytes:42199180 (40.2 MiB) TX bytes:12468716 (11.8 MiB) lo Link encap:Local Loopback inet addr:127.0.0.1 Mask:255.0.0.0 inet6 addr: ::1/128 Scope:Host UP LOOPBACK RUNNING MTU:65536 Metric:1 RX packets:2068 errors:0 dropped:0 overruns:0 frame:0 TX packets:2068 errors:0 dropped:0 overruns:0 carrier:0 collisions:0 txqueuelen:0 RX bytes:782900 (764.5 KiB) TX bytes:782900 (764.5 KiB) local-node Link encap:Ethernet HWaddr 16:41:95:40:F7:DC inet6 addr: fd74:fdaa:9dc4::127/128 Scope:Global inet6 addr: fe80::1441:95ff:fe40:f7dc/64 Scope:Link UP BROADCAST RUNNING MULTICAST MTU:1500 Metric:1 RX packets:54333 errors:0 dropped:0 overruns:0 frame:0 TX packets:12948 errors:0 dropped:0 overruns:0 carrier:0 collisions:0 txqueuelen:0 RX bytes:3702583 (3.5 MiB) TX bytes:2020898 (1.9 MiB) primary0 Link encap:Ethernet HWaddr DE:4A:0C:F6:6F:8B UP BROADCAST RUNNING NOARP MTU:1532 Metric:1 RX packets:0 errors:0 dropped:0 overruns:0 frame:0 TX packets:534242 errors:0 dropped:0 overruns:0 carrier:0 collisions:0 txqueuelen:0 RX bytes:0 (0.0 B) TX bytes:64821698 (61.8 MiB) root@FF-Bad-Iburg-Pfarrheim-Glane-01:~# cat /etc/config/wireless config wifi-device 'radio0' option type 'mac80211' option hwmode '11g' option path 'platform/qca955x_wmac' option htmode 'HT20' option channel '6' option country 'DE' list supported_rates '6000' list supported_rates '9000' list supported_rates '12000' list supported_rates '18000' list supported_rates '24000' list supported_rates '36000' list supported_rates '48000' list supported_rates '54000' list basic_rate '6000' list basic_rate '9000' list basic_rate '18000' list basic_rate '36000' list basic_rate '54000' config wifi-iface 'ibss_radio0' option ifname 'ibss0' option network 'ibss_radio0' option device 'radio0' option disabled '0' option mcast_rate '12000' option mode 'adhoc' option macaddr 'de:4a:0c:f6:6f:8a' option ssid 'mesh.ffnw' option bssid '02:00:0A:12:58:00' config wifi-iface 'mesh_radio0' option ifname 'mesh0' option network 'mesh_radio0' option device 'radio0' option mesh_fwding '0' option mcast_rate '12000' option mode 'mesh' option macaddr 'de:4a:0c:f6:6f:89' option disabled '1' option mesh_id 'ffnw-mesh_02:00:0a:12:58:00' config wifi-iface 'client_radio0' option ifname 'client0' option network 'client' option disabled '0' option device 'radio0' option mode 'ap' option macaddr 'de:4a:0c:f6:6f:88' option ssid 'nordwest.freifunk.net' root@FF-Bad-Iburg-Pfarrheim-Glane-01:~# iwinfo client0 ESSID: "nordwest.freifunk.net" Access Point: DE:4A:0C:F6:6F:88 Mode: Master Channel: 6 (2.437 GHz) Tx-Power: 15 dBm Link Quality: unknown/70 Signal: unknown Noise: -95 dBm Bit Rate: unknown Encryption: none Type: nl80211 HW Mode(s): 802.11bgn Hardware: unknown [Generic MAC80211] TX power offset: unknown Frequency offset: unknown Supports VAPs: yes PHY name: phy0 ibss0 ESSID: "mesh.ffnw" Access Point: 02:00:0A:12:58:00 Mode: Ad-Hoc Channel: 6 (2.437 GHz) Tx-Power: 15 dBm Link Quality: 29/70 Signal: -81 dBm Noise: -95 dBm Bit Rate: 20.3 MBit/s Encryption: unknown Type: nl80211 HW Mode(s): 802.11bgn Hardware: unknown [Generic MAC80211] TX power offset: unknown Frequency offset: unknown Supports VAPs: yes PHY name: phy0 /etc/init.d/micrond status Syntax: /etc/init.d/micrond [command] Available commands: start Start the service stop Stop the service restart Restart the service reload Reload configuration files (or restart if that fails) enable Enable service autostart disable Disable service autostart LG Lorenz Am 17.08.2017 um 14:33 schrieb Jan-Tarek Butt via Dev:
Hi Lorenz,
heute morgen wollte ein Kabelmeshrouter nach automatischem Reboot nicht wieder online kommen, aber ich konnte noch per link-local rauf und habe mal ein wenig herumprobiert. Noch ist er nicht wieder online, aber ich dachte mir, die Ausgaben könnten fürs Firmware-debugging interessant sein. Deshalb hier:
Abermals danke für diese wirklich hilfreichen Informationen.
---------------------------8<--------------------------- root@FF-Bad-Iburg-Pfarrheim-Glane-01:~# hoodselector No VPN connection found Testing neighboring adhoc networks for batman advanced gw connection. The following wireless networks have been found: 73 2437 02:00:0a:12:58:00 mesh.ffnw After filtering we will test the following wireless networks: No neighboring freifunk batman advanced mesh found. Command failed: Request timed out Failed to parse json data: unexpected end of data currend configuration are not defined as hood VPN stopped. Command failed: Request timed out Command failed: Request timed out Command failed: Request timed out Wireless restarted. IBSS needed reconfiguration. Applied new settings and restarted. Command failed: Request timed out Command failed: Request timed out Command failed: Request timed out Wireless restarted. MESH needed reconfiguration. Applied new settings and restarted. Fastd needed reconfiguration. Stopped and applied new settings. VPN enable. VPN started. Interface br-client restarted. VPN needed reconfiguration. Applied new settings and restarted. Set hood "default" Set defaulthood. Command failed: Request timed out Failed to parse json data: unexpected end of dataLorenz Command failed: Request timed out /usr/bin/lua: /usr/sbin/hoodselector:132: attempt to index local 'e' (a nil value) stack traceback: /usr/sbin/hoodselector:132: in function 'r' /usr/sbin/hoodselector:205: in function 'h' /usr/sbin/hoodselector:938: in main chunk [C]: ? --------------------------->8---------------------------
Die "Request timed out" könnten durch das 11s Netzwerk entstehen. den nil Index untersuche ich.
im logread steht nur alle paar Minuten:
---------------------------8<--------------------------- Thu Aug 3 16:42:24 2017 kern.emerg kernel: [23206.120000] unregister_netdevice: waiting for bat0 to become free. Usage count = 4 Thu Aug 3 16:42:24 2017 kern.emerg kernel: [23206.380000] unregister_netdevice: waiting for primary0 to become free. Usage count = 1 Thu Aug 3 16:42:24 2017 kern.emerg kernel: [23206.640000] unregister_netdevice: waiting for local-node to become free. Usage count = 1 --------------------------->8---------------------------
Kannst du noch die ausgaben von ifconfig, iwinfo und cat /etc/config/wireless hier Posten? Die helfen mir den zustand des Routers einzuschätzen.
die systemzeit ist offensichtlich falsch, aber das liegt sicherlich an der Nichterreichbarkeit jeglicher ntp-server. Ich werde ihn bis 18 Uhr erstmal nicht rebooten, sondern warten, ob jemand eine Idee hat, welche Ausgaben außerdem aufschlussreich sein könnten. Die /tmp/hoodselector_error war übrigens leer
Jo die Systemzeit ist abhängig von der Netzwerk Verbindung wie du es ja schon gesagt hast.
Das die /tmp/hoodselector_error leer ist kann ich mir nur dadurch erklären das der hoodselector garnicht via cron läuft. evtl. ist der Router beim booten irgendwo hängen geblieben so das der cron daemon noch garnicht aktiv ist. Ich hab gerade nicht den passenden befehl parat um zu prüfen ob der daemon läuft versuch mal /etc/init.d/cron status oder /etc/init.d/micron status oder so ähnlich.
Schöne Grüße Tarek
_______________________________________________ Dev mailing list Dev@lists.ffnw.de https://lists.ffnw.de/mailman/listinfo/dev
leider wurde die Kiste wahrscheinlich mittlerweile powercycled; die uptime ist ca 3,5 Std und weder Thomas noch ich haben ihn rebooted. Beim nächsten live-debugging-kandidaten tue ich die mir bekannten keys drauf, damit es nicht an meiner zeitlichen Verfügbarkeit hängt.
Wahrscheinlich, hing die Kiste beim booten und hat sich selbst wieder eingekrigt.
mesh_radio0 -- also 802.11s -- ist dort schon seit längerem (vor etliche reboots) deakiviert worden. kann es trotzdem Probleme machen? Auch wenn es jetzt vermutlich uninteressant ist, hier die gewünschten infos:
Nein wenn es deaktiviert ist, dann liegt es wahrscheinlich nicht daran.
root@FF-Bad-Iburg-Pfarrheim-Glane-01:~# ifconfig bat0 Link encap:Ethernet HWaddr 10:FE:ED:C2:41:68 inet6 addr: fe80::12fe:edff:fec2:4168/64 Scope:Link UP BROADCAST RUNNING MULTICAST MTU:1500 Metric:1 RX packets:497090 errors:0 dropped:0 overruns:0 frame:0 TX packets:61066 errors:0 dropped:60 overruns:0 carrier:0 collisions:0 txqueuelen:0
<schnips>
/etc/init.d/micrond status Syntax: /etc/init.d/micrond [command]
Available commands: start Start the service stop Stop the service restart Restart the service reload Reload configuration files (or restart if that fails) enable Enable service autostart disable Disable service autostart
Die infos sind nun nicht mehr notwendig. Ich vermute das es ein Problem von gluon ist. Der micron schien zu dem Zeitpunk nicht zu laufen, da der Router irgendwo beim booten hing. Schöne Grüße Tarek
participants (2)
-
Jan-Tarek Butt -
lrnzo