Problem beim Freischalten des Internets

RubenKelevra commented 11 years ago

Ich habe zweifach ein Problem festgestellt beim Freischalten des Internets in einem einzelnen Knoten mit Internetanbindung und einmal mit einer Drohne die das Internet weiter gibt.

Hier wird nach einem Druck auf Akzeptieren das Internet offensichtlich nicht freigeschaltet und es erfolgt eine erneute Weiterleitung auf die Routerseite.

Bei Auftritt des Problems mit Drone/Queen hab ich danach ins Log der Queen geschaut.

Vermutlich steht das Problem im Zusammenhang mit dem Logeintrag hier:

Oct 31 17:23:02 wk-001 user.notice fsm: Node is online Oct 31 17:23:09 wk-001 daemon.info n2n[7590]: Registering with supernode Oct 31 17:23:09 wk-001 daemon.info n2n[7590]: Received REGISTER_ACK from remote peer [ip=88.152.235.101:56789] Oct 31 17:23:09 wk-001 daemon.info n2n[7612]: Registering with supernode Oct 31 17:23:10 wk-001 daemon.info n2n[7612]: Received REGISTER_ACK from remote peer [ip=78.47.181.173:31337] Oct 31 17:23:38 wk-001 daemon.info dnsmasq-dhcp[2669]: DHCPDISCOVER(br-mesh) 38:59:f9:6b:9c:07 Oct 31 17:23:38 wk-001 daemon.info dnsmasq-dhcp[2669]: DHCPOFFER(br-mesh) 10.52.0.240 38:59:f9:6b:9c:07 Oct 31 17:23:38 wk-001 daemon.info dnsmasq-dhcp[2669]: DHCPREQUEST(br-mesh) 10.52.0.240 38:59:f9:6b:9c:07 Oct 31 17:23:38 wk-001 daemon.info dnsmasq-dhcp[2669]: DHCPACK(br-mesh) 10.52.0.240 38:59:f9:6b:9c:07 i3 Oct 31 17:23:41 wk-001 kern.warn kernel: [24696.440000] ------------[ cut here ]------------ Oct 31 17:23:41 wk-001 kern.warn kernel: [24696.450000] WARNING: at /home/lcb01/ffrhein/openwrt/attitude_adjustment/build_dir/linux-ar71xx_generic/compat-wireless-2012-09-07/net/mac80211/sta_info.c:304 0x80c832c0() Oct 31 17:23:41 wk-001 kern.warn kernel: [truncated] [24696.460000] Modules linked in: ath79_wdt ohci_hcd ledtrig_usbdev xt_LED ledtrig_netdev batman_adv(O) ip6t_REJECT ip6t_LOG ip6t_rt ip6t_hbh ip6t_mh ip6t_ipv6header ip6t_frag ip6t_eui64 ip6t_ah ip6table_raw ip6_queu Oct 31 17:23:41 wk-001 kern.warn kernel: [24696.550000] Call Trace:[<8026584c>] 0x8026584c Oct 31 17:23:41 wk-001 kern.warn kernel: [24696.560000] [<8026584c>] 0x8026584c Oct 31 17:23:41 wk-001 kern.warn kernel: [24696.560000] [<8007198c>] 0x8007198c Oct 31 17:23:41 wk-001 kern.warn kernel: [24696.560000] [<80c832c0>] 0x80c832c0 Oct 31 17:23:41 wk-001 kern.warn kernel: [24696.570000] [<800719d0>] 0x800719d0 Oct 31 17:23:41 wk-001 kern.warn kernel: [24696.570000] [<80c832c0>] 0x80c832c0 Oct 31 17:23:41 wk-001 kern.warn kernel: [24696.570000] [<80c8b108>] 0x80c8b108 Oct 31 17:23:41 wk-001 kern.warn kernel: [24696.580000] [<80c8b7fc>] 0x80c8b7fc Oct 31 17:23:41 wk-001 kern.warn kernel: [24696.580000] [<80c8b9f8>] 0x80c8b9f8 Oct 31 17:23:41 wk-001 kern.warn kernel: [24696.580000] [<80c8becc>] 0x80c8becc Oct 31 17:23:41 wk-001 kern.warn kernel: [24696.590000] [<80c8c274>] 0x80c8c274 Oct 31 17:23:41 wk-001 kern.warn kernel: [24696.590000] [<80c8e080>] 0x80c8e080 Oct 31 17:23:41 wk-001 kern.warn kernel: [24696.600000] [<80094704>] 0x80094704 Oct 31 17:23:41 wk-001 kern.warn kernel: [24696.600000] [<80c8ddbc>] 0x80c8ddbc Oct 31 17:23:41 wk-001 kern.warn kernel: [24696.600000] [<80085de0>] 0x80085de0 Oct 31 17:23:41 wk-001 kern.warn kernel: [24696.610000] [<80095190>] 0x80095190 Oct 31 17:23:41 wk-001 kern.warn kernel: [24696.610000] [<80086890>] 0x80086890 Oct 31 17:23:41 wk-001 kern.warn kernel: [24696.610000] [<80268ef4>] 0x80268ef4 Oct 31 17:23:41 wk-001 kern.warn kernel: [24696.620000] [<80086664>] 0x80086664 Oct 31 17:23:41 wk-001 kern.warn kernel: [24696.620000] [<80086664>] 0x80086664 Oct 31 17:23:41 wk-001 kern.warn kernel: [24696.620000] [<8008a1b4>] 0x8008a1b4 Oct 31 17:23:41 wk-001 kern.warn kernel: [24696.630000] [<80064a70>] 0x80064a70 Oct 31 17:23:41 wk-001 kern.warn kernel: [24696.630000] [<8008a12c>] 0x8008a12c Oct 31 17:23:41 wk-001 kern.warn kernel: [24696.630000] [<80064a60>] 0x80064a60 Oct 31 17:23:41 wk-001 kern.warn kernel: [24696.640000] Oct 31 17:23:41 wk-001 kern.warn kernel: [24696.640000] ---[ end trace 98266c279c0908ef ]--- Oct 31 17:23:43 wk-001 kern.warn kernel: [24698.290000] ------------[ cut here ]------------ Oct 31 17:23:43 wk-001 kern.warn kernel: [24698.290000] WARNING: at /home/lcb01/ffrhein/openwrt/attitude_adjustment/build_dir/linux-ar71xx_generic/compat-wireless-2012-09-07/net/mac80211/sta_info.c:304 0x80c832c0() Oct 31 17:23:43 wk-001 kern.warn kernel: [truncated] [24698.310000] Modules linked in: ath79_wdt ohci_hcd ledtrig_usbdev xt_LED ledtrig_netdev batman_adv(O) ip6t_REJECT ip6t_LOG ip6t_rt ip6t_hbh ip6t_mh ip6t_ipv6header ip6t_frag ip6t_eui64 ip6t_ah ip6table_raw ip6_queu Oct 31 17:23:43 wk-001 kern.warn kernel: [24698.400000] Call Trace:[<8026584c>] 0x8026584c Oct 31 17:23:43 wk-001 kern.warn kernel: [24698.400000] [<8026584c>] 0x8026584c Oct 31 17:23:43 wk-001 kern.warn kernel: [24698.410000] [<8007198c>] 0x8007198c Oct 31 17:23:43 wk-001 kern.warn kernel: [24698.410000] [<80c832c0>] 0x80c832c0 Oct 31 17:23:43 wk-001 kern.warn kernel: [24698.410000] [<800719d0>] 0x800719d0 Oct 31 17:23:43 wk-001 kern.warn kernel: [24698.420000] [<80c832c0>] 0x80c832c0 Oct 31 17:23:43 wk-001 kern.warn kernel: [24698.420000] [<80c8b108>] 0x80c8b108 Oct 31 17:23:43 wk-001 kern.warn kernel: [24698.420000] [<80c8b7fc>] 0x80c8b7fc Oct 31 17:23:43 wk-001 kern.warn kernel: [24698.430000] [<80c8b9f8>] 0x80c8b9f8 Oct 31 17:23:43 wk-001 kern.warn kernel: [24698.430000] [<80c8becc>] 0x80c8becc Oct 31 17:23:43 wk-001 kern.warn kernel: [24698.440000] [<80c8c274>] 0x80c8c274 Oct 31 17:23:43 wk-001 kern.warn kernel: [24698.440000] [<80c8e080>] 0x80c8e080 Oct 31 17:23:43 wk-001 kern.warn kernel: [24698.440000] [<80094704>] 0x80094704 Oct 31 17:23:43 wk-001 kern.warn kernel: [24698.450000] [<80c8ddbc>] 0x80c8ddbc Oct 31 17:23:43 wk-001 kern.warn kernel: [24698.450000] [<80085de0>] 0x80085de0 Oct 31 17:23:43 wk-001 kern.warn kernel: [24698.450000] [<80095190>] 0x80095190 Oct 31 17:23:43 wk-001 kern.warn kernel: [24698.460000] [<80086890>] 0x80086890 Oct 31 17:23:43 wk-001 kern.warn kernel: [24698.460000] [<80268ef4>] 0x80268ef4 Oct 31 17:23:43 wk-001 kern.warn kernel: [24698.460000] [<80086664>] 0x80086664 Oct 31 17:23:43 wk-001 kern.warn kernel: [24698.470000] [<80086664>] 0x80086664 Oct 31 17:23:43 wk-001 kern.warn kernel: [24698.470000] [<8008a1b4>] 0x8008a1b4 Oct 31 17:23:43 wk-001 kern.warn kernel: [24698.470000] [<80064a70>] 0x80064a70 Oct 31 17:23:43 wk-001 kern.warn kernel: [24698.480000] [<8008a12c>] 0x8008a12c Oct 31 17:23:43 wk-001 kern.warn kernel: [24698.480000] [<80064a60>] 0x80064a60 Oct 31 17:23:43 wk-001 kern.warn kernel: [24698.480000] Oct 31 17:23:43 wk-001 kern.warn kernel: [24698.490000] ---[ end trace 98266c279c0908f0 ]--- Oct 31 17:24:01 wk-001 cron.info crond[1593]: crond: USER root pid 8198 cmd /sbin/p2ptbl gossip /tmp/p2ptbl/gwip 500 br-mesh Oct 31 17:24:01 wk-001 cron.info crond[1593]: crond: USER root pid 8199 cmd /sbin/p2ptbl gossip /tmp/p2ptbl/splash 500 br-mesh Oct 31 17:24:01 wk-001 cron.info crond[1593]: crond: USER root pid 8201 cmd /sbin/fsm watch inetable Oct 31 17:24:01 wk-001 cron.info crond[1593]: crond: USER root pid 8205 cmd /sbin/splash_sync Oct 31 17:24:02 wk-001 user.notice fsm: Node is online

RubenKelevra commented 11 years ago

Grade das selbe Problem an einem Notebook gehabt. Betriebssystem Windows 8. Allerdings hat sich die Freischaltung hier nur verzögert, nach 10 Sekunden etwa war das Internet freigeschaltet.

Nichts, für mich, auffälliges im Log.

LG Ruben

root@wk-001:~# logread Nov 6 13:19:01 wk-001 cron.info crond[1592]: crond: USER root pid 30975 cmd /sbin/p2ptbl gossip /tmp/p2ptbl/splash 500 br-mesh Nov 6 13:19:01 wk-001 cron.info crond[1592]: crond: USER root pid 30976 cmd /sbin/fsm watch inetable Nov 6 13:19:01 wk-001 cron.info crond[1592]: crond: USER root pid 30977 cmd /sbin/splash_sync Nov 6 13:19:01 wk-001 user.notice fsm: Node is online Nov 6 13:19:09 wk-001 daemon.info n2n[30515]: Registering with supernode Nov 6 13:19:09 wk-001 daemon.info n2n[30491]: Registering with supernode Nov 6 13:19:09 wk-001 daemon.info n2n[30491]: Received REGISTER_ACK from remote peer [ip=88.152.235.101:56789] Nov 6 13:20:01 wk-001 cron.info crond[1592]: crond: USER root pid 31115 cmd /sbin/p2ptbl gossip /tmp/p2ptbl/gwip 500 br-mesh Nov 6 13:20:01 wk-001 cron.info crond[1592]: crond: USER root pid 31116 cmd /sbin/p2ptbl gossip /tmp/p2ptbl/splash 500 br-mesh Nov 6 13:20:01 wk-001 cron.info crond[1592]: crond: USER root pid 31119 cmd /sbin/p2ptbl gossip /tmp/p2ptbl/update 500 br-mesh Nov 6 13:20:01 wk-001 cron.info crond[1592]: crond: USER root pid 31120 cmd /sbin/fsm watch inetable Nov 6 13:20:01 wk-001 cron.info crond[1592]: crond: USER root pid 31121 cmd /sbin/fsm watch update Nov 6 13:20:01 wk-001 cron.info crond[1592]: crond: USER root pid 31127 cmd /sbin/splash_sync Nov 6 13:20:01 wk-001 cron.info crond[1592]: crond: USER root pid 31129 cmd /sbin/n2n_watchdog Nov 6 13:20:02 wk-001 user.notice fsm: Node is online Nov 6 13:20:07 wk-001 kern.info kernel: [154183.840000] batman_adv: bat0: Interface deactivated: n2n2 Nov 6 13:20:07 wk-001 daemon.debug radvd[1619]: attempting to reread config file Nov 6 13:20:07 wk-001 daemon.debug radvd[1619]: resuming normal operation Nov 6 13:20:07 wk-001 daemon.debug radvd[1619]: attempting to reread config file Nov 6 13:20:07 wk-001 daemon.debug radvd[1619]: resuming normal operation Nov 6 13:20:07 wk-001 kern.info kernel: [154183.860000] batman_adv: bat0: Removing interface: n2n2 Nov 6 13:20:07 wk-001 daemon.debug radvd[1619]: attempting to reread config file Nov 6 13:20:07 wk-001 daemon.debug radvd[1619]: resuming normal operation Nov 6 13:20:07 wk-001 kern.info kernel: [154183.870000] batman_adv: bat0: Interface deactivated: n2n1 Nov 6 13:20:07 wk-001 kern.info kernel: [154183.870000] batman_adv: bat0: Removing interface: n2n1 Nov 6 13:20:07 wk-001 daemon.debug radvd[1619]: attempting to reread config file Nov 6 13:20:07 wk-001 daemon.debug radvd[1619]: resuming normal operation Nov 6 13:20:07 wk-001 daemon.debug radvd[1619]: attempting to reread config file Nov 6 13:20:07 wk-001 daemon.debug radvd[1619]: resuming normal operation Nov 6 13:20:08 wk-001 daemon.debug radvd[1619]: attempting to reread config file Nov 6 13:20:08 wk-001 daemon.debug radvd[1619]: resuming normal operation Nov 6 13:20:08 wk-001 daemon.debug radvd[1619]: attempting to reread config file Nov 6 13:20:08 wk-001 daemon.info n2n[31364]: Registering with supernode Nov 6 13:20:08 wk-001 daemon.info n2n[31364]: Nov 6 13:20:08 wk-001 daemon.info n2n[31364]: Ready Nov 6 13:20:08 wk-001 daemon.info n2n[31364]: Received REGISTER_ACK from remote peer [ip=88.152.235.101:56789] Nov 6 13:20:08 wk-001 daemon.info n2n[31364]: STATUS: pending=0, operational=0 Nov 6 13:20:08 wk-001 daemon.debug radvd[1619]: resuming normal operation Nov 6 13:20:08 wk-001 daemon.debug radvd[1619]: attempting to reread config file Nov 6 13:20:08 wk-001 daemon.debug radvd[1619]: resuming normal operation Nov 6 13:20:08 wk-001 kern.info kernel: [154185.170000] batman_adv: bat0: Adding interface: n2n1 Nov 6 13:20:08 wk-001 kern.info kernel: [154185.170000] batman_adv: bat0: The MTU of interface n2n1 is too small (1400) to handle the transport of batman-adv packets. Packets going over this interface will be fragmented on layer2 which could impact the performance. Se Nov 6 13:20:08 wk-001 kern.info kernel: [154185.200000] batman_adv: bat0: Interface activated: n2n1 Nov 6 13:20:08 wk-001 daemon.debug radvd[1619]: attempting to reread config file Nov 6 13:20:08 wk-001 daemon.debug radvd[1619]: resuming normal operation Nov 6 13:20:08 wk-001 daemon.info n2n[31386]: Registering with supernode Nov 6 13:20:08 wk-001 daemon.info n2n[31386]: Nov 6 13:20:08 wk-001 daemon.info n2n[31386]: Ready Nov 6 13:20:08 wk-001 daemon.debug radvd[1619]: attempting to reread config file Nov 6 13:20:08 wk-001 daemon.debug radvd[1619]: resuming normal operation Nov 6 13:20:08 wk-001 daemon.debug radvd[1619]: attempting to reread config file Nov 6 13:20:08 wk-001 daemon.info n2n[31386]: STATUS: pending=0, operational=0 Nov 6 13:20:08 wk-001 daemon.debug radvd[1619]: resuming normal operation Nov 6 13:20:08 wk-001 kern.info kernel: [154185.430000] batman_adv: bat0: Adding interface: n2n2 Nov 6 13:20:08 wk-001 user.notice root: n2n restarted (no neighbors via n2n) Nov 6 13:20:08 wk-001 kern.info kernel: [154185.440000] batman_adv: bat0: The MTU of interface n2n2 is too small (1400) to handle the transport of batman-adv packets. Packets going over this interface will be fragmented on layer2 which could impact the performance. Se Nov 6 13:20:08 wk-001 kern.info kernel: [154185.460000] batman_adv: bat0: Interface activated: n2n2 Nov 6 13:20:09 wk-001 daemon.info n2n[31386]: Received REGISTER_ACK from remote peer [ip=78.47.181.173:31337] Nov 6 13:21:01 wk-001 cron.info crond[1592]: crond: USER root pid 31417 cmd /sbin/p2ptbl gossip /tmp/p2ptbl/gwip 500 br-mesh Nov 6 13:21:01 wk-001 cron.info crond[1592]: crond: USER root pid 31418 cmd /sbin/p2ptbl gossip /tmp/p2ptbl/splash 500 br-mesh Nov 6 13:21:01 wk-001 cron.info crond[1592]: crond: USER root pid 31419 cmd /sbin/fsm watch inetable Nov 6 13:21:01 wk-001 cron.info crond[1592]: crond: USER root pid 31420 cmd /sbin/splash_sync Nov 6 13:21:01 wk-001 user.notice fsm: Node is online Nov 6 13:21:08 wk-001 daemon.info n2n[31386]: Registering with supernode Nov 6 13:21:08 wk-001 daemon.info n2n[31364]: Registering with supernode Nov 6 13:21:08 wk-001 daemon.info n2n[31364]: Received REGISTER_ACK from remote peer [ip=88.152.235.101:56789] Nov 6 13:21:08 wk-001 daemon.info n2n[31386]: Received REGISTER_ACK from remote peer [ip=78.47.181.173:31337] Nov 6 13:22:01 wk-001 cron.info crond[1592]: crond: USER root pid 31558 cmd /sbin/p2ptbl gossip /tmp/p2ptbl/gwip 500 br-mesh Nov 6 13:22:01 wk-001 cron.info crond[1592]: crond: USER root pid 31559 cmd /sbin/p2ptbl gossip /tmp/p2ptbl/splash 500 br-mesh Nov 6 13:22:01 wk-001 cron.info crond[1592]: crond: USER root pid 31560 cmd /sbin/fsm watch inetable Nov 6 13:22:01 wk-001 cron.info crond[1592]: crond: USER root pid 31562 cmd /sbin/splash_sync Nov 6 13:22:01 wk-001 user.notice fsm: Node is online Nov 6 13:22:08 wk-001 daemon.info n2n[31364]: Registering with supernode Nov 6 13:22:08 wk-001 daemon.info n2n[31364]: Received REGISTER_ACK from remote peer [ip=88.152.235.101:56789] Nov 6 13:22:08 wk-001 daemon.info n2n[31386]: Registering with supernode Nov 6 13:23:01 wk-001 cron.info crond[1592]: crond: USER root pid 31699 cmd /sbin/p2ptbl gossip /tmp/p2ptbl/gwip 500 br-mesh Nov 6 13:23:01 wk-001 cron.info crond[1592]: crond: USER root pid 31700 cmd /sbin/p2ptbl gossip /tmp/p2ptbl/splash 500 br-mesh Nov 6 13:23:01 wk-001 cron.info crond[1592]: crond: USER root pid 31701 cmd /sbin/fsm watch inetable Nov 6 13:23:01 wk-001 cron.info crond[1592]: crond: USER root pid 31702 cmd /sbin/splash_sync Nov 6 13:23:02 wk-001 user.notice fsm: Node is online Nov 6 13:23:08 wk-001 daemon.info n2n[31364]: Registering with supernode Nov 6 13:23:08 wk-001 daemon.info n2n[31386]: Registering with supernode Nov 6 13:23:08 wk-001 daemon.info n2n[31364]: Received REGISTER_ACK from remote peer [ip=88.152.235.101:56789] Nov 6 13:23:08 wk-001 daemon.info n2n[31386]: Received REGISTER_ACK from remote peer [ip=78.47.181.173:31337] Nov 6 13:24:01 wk-001 cron.info crond[1592]: crond: USER root pid 31846 cmd /sbin/p2ptbl gossip /tmp/p2ptbl/gwip 500 br-mesh Nov 6 13:24:01 wk-001 cron.info crond[1592]: crond: USER root pid 31847 cmd /sbin/p2ptbl gossip /tmp/p2ptbl/splash 500 br-mesh Nov 6 13:24:01 wk-001 cron.info crond[1592]: crond: USER root pid 31849 cmd /sbin/fsm watch inetable Nov 6 13:24:01 wk-001 cron.info crond[1592]: crond: USER root pid 31851 cmd /sbin/splash_sync Nov 6 13:24:02 wk-001 user.notice fsm: Node is online Nov 6 13:24:08 wk-001 daemon.info n2n[31364]: Registering with supernode Nov 6 13:24:08 wk-001 daemon.info n2n[31364]: Received REGISTER_ACK from remote peer [ip=88.152.235.101:56789] Nov 6 13:24:08 wk-001 daemon.info n2n[31386]: Registering with supernode Nov 6 13:24:08 wk-001 daemon.info n2n[31386]: Received REGISTER_ACK from remote peer [ip=78.47.181.173:31337] Nov 6 13:25:01 wk-001 cron.info crond[1592]: crond: USER root pid 31987 cmd /sbin/p2ptbl gossip /tmp/p2ptbl/gwip 500 br-mesh Nov 6 13:25:01 wk-001 cron.info crond[1592]: crond: USER root pid 31988 cmd /sbin/p2ptbl gossip /tmp/p2ptbl/splash 500 br-mesh Nov 6 13:25:01 wk-001 cron.info crond[1592]: crond: USER root pid 31989 cmd /sbin/p2ptbl gossip /tmp/p2ptbl/update 500 br-mesh Nov 6 13:25:01 wk-001 cron.info crond[1592]: crond: USER root pid 31990 cmd /sbin/fsm watch inetable Nov 6 13:25:01 wk-001 cron.info crond[1592]: crond: USER root pid 31991 cmd /sbin/fsm watch update Nov 6 13:25:01 wk-001 cron.info crond[1592]: crond: USER root pid 31992 cmd /sbin/splash_sync Nov 6 13:25:01 wk-001 cron.info crond[1592]: crond: USER root pid 31993 cmd /sbin/n2n_watchdog Nov 6 13:25:02 wk-001 user.notice fsm: Node is online Nov 6 13:25:07 wk-001 kern.info kernel: [154484.210000] batman_adv: bat0: Interface deactivated: n2n2 Nov 6 13:25:07 wk-001 daemon.debug radvd[1619]: attempting to reread config file Nov 6 13:25:07 wk-001 daemon.debug radvd[1619]: resuming normal operation Nov 6 13:25:07 wk-001 daemon.debug radvd[1619]: attempting to reread config file Nov 6 13:25:07 wk-001 daemon.debug radvd[1619]: resuming normal operation Nov 6 13:25:07 wk-001 kern.info kernel: [154484.230000] batman_adv: bat0: Removing interface: n2n2 Nov 6 13:25:07 wk-001 daemon.debug radvd[1619]: attempting to reread config file Nov 6 13:25:07 wk-001 daemon.debug radvd[1619]: resuming normal operation Nov 6 13:25:07 wk-001 kern.info kernel: [154484.240000] batman_adv: bat0: Interface deactivated: n2n1 Nov 6 13:25:07 wk-001 kern.info kernel: [154484.240000] batman_adv: bat0: Removing interface: n2n1 Nov 6 13:25:07 wk-001 daemon.debug radvd[1619]: attempting to reread config file Nov 6 13:25:07 wk-001 daemon.debug radvd[1619]: resuming normal operation Nov 6 13:25:07 wk-001 daemon.debug radvd[1619]: attempting to reread config file Nov 6 13:25:07 wk-001 daemon.debug radvd[1619]: resuming normal operation Nov 6 13:25:08 wk-001 daemon.debug radvd[1619]: attempting to reread config file Nov 6 13:25:08 wk-001 daemon.debug radvd[1619]: resuming normal operation Nov 6 13:25:08 wk-001 daemon.info n2n[32231]: Registering with supernode Nov 6 13:25:08 wk-001 daemon.info n2n[32231]: Nov 6 13:25:08 wk-001 daemon.info n2n[32231]: Ready Nov 6 13:25:08 wk-001 daemon.info n2n[32231]: Received REGISTER_ACK from remote peer [ip=88.152.235.101:56789] Nov 6 13:25:08 wk-001 daemon.info n2n[32231]: STATUS: pending=0, operational=0 Nov 6 13:25:08 wk-001 daemon.debug radvd[1619]: attempting to reread config file Nov 6 13:25:08 wk-001 daemon.debug radvd[1619]: resuming normal operation Nov 6 13:25:08 wk-001 daemon.debug radvd[1619]: attempting to reread config file Nov 6 13:25:08 wk-001 daemon.debug radvd[1619]: resuming normal operation Nov 6 13:25:09 wk-001 kern.info kernel: [154485.540000] batman_adv: bat0: Adding interface: n2n1 Nov 6 13:25:09 wk-001 kern.info kernel: [154485.540000] batman_adv: bat0: The MTU of interface n2n1 is too small (1400) to handle the transport of batman-adv packets. Packets going over this interface will be fragmented on layer2 which could impact the performance. Se Nov 6 13:25:09 wk-001 kern.info kernel: [154485.560000] batman_adv: bat0: Interface activated: n2n1 Nov 6 13:25:09 wk-001 daemon.debug radvd[1619]: attempting to reread config file Nov 6 13:25:09 wk-001 daemon.debug radvd[1619]: resuming normal operation Nov 6 13:25:09 wk-001 daemon.debug radvd[1619]: attempting to reread config file Nov 6 13:25:09 wk-001 daemon.debug radvd[1619]: resuming normal operation Nov 6 13:25:09 wk-001 daemon.debug radvd[1619]: attempting to reread config file Nov 6 13:25:09 wk-001 daemon.debug radvd[1619]: resuming normal operation Nov 6 13:25:09 wk-001 daemon.info n2n[32257]: Registering with supernode Nov 6 13:25:09 wk-001 daemon.info n2n[32257]: Nov 6 13:25:09 wk-001 daemon.info n2n[32257]: Ready Nov 6 13:25:09 wk-001 daemon.info n2n[32257]: STATUS: pending=0, operational=0 Nov 6 13:25:09 wk-001 kern.info kernel: [154485.800000] batman_adv: bat0: Adding interface: n2n2 Nov 6 13:25:09 wk-001 kern.info kernel: [154485.800000] batman_adv: bat0: The MTU of interface n2n2 is too small (1400) to handle the transport of batman-adv packets. Packets going over this interface will be fragmented on layer2 which could impact the performance. Se Nov 6 13:25:09 wk-001 kern.info kernel: [154485.830000] batman_adv: bat0: Interface activated: n2n2 Nov 6 13:25:09 wk-001 user.notice root: n2n restarted (no neighbors via n2n) Nov 6 13:25:09 wk-001 daemon.info n2n[32257]: Received REGISTER_ACK from remote peer [ip=78.47.181.173:31337] Nov 6 13:26:01 wk-001 cron.info crond[1592]: crond: USER root pid 32367 cmd /sbin/p2ptbl gossip /tmp/p2ptbl/gwip 500 br-mesh Nov 6 13:26:01 wk-001 cron.info crond[1592]: crond: USER root pid 32368 cmd /sbin/p2ptbl gossip /tmp/p2ptbl/splash 500 br-mesh Nov 6 13:26:01 wk-001 cron.info crond[1592]: crond: USER root pid 32370 cmd /sbin/fsm watch inetable Nov 6 13:26:01 wk-001 cron.info crond[1592]: crond: USER root pid 32371 cmd /sbin/splash_sync Nov 6 13:26:02 wk-001 user.notice fsm: Node is online Nov 6 13:26:08 wk-001 daemon.info n2n[32231]: Registering with supernode Nov 6 13:26:08 wk-001 daemon.info n2n[32231]: Received REGISTER_ACK from remote peer [ip=88.152.235.101:56789] Nov 6 13:26:09 wk-001 daemon.info n2n[32257]: Registering with supernode Nov 6 13:27:01 wk-001 cron.info crond[1592]: crond: USER root pid 32688 cmd /sbin/p2ptbl gossip /tmp/p2ptbl/gwip 500 br-mesh Nov 6 13:27:01 wk-001 cron.info crond[1592]: crond: USER root pid 32689 cmd /sbin/p2ptbl gossip /tmp/p2ptbl/splash 500 br-mesh Nov 6 13:27:01 wk-001 cron.info crond[1592]: crond: USER root pid 32690 cmd /sbin/fsm watch inetable Nov 6 13:27:01 wk-001 cron.info crond[1592]: crond: USER root pid 32691 cmd /sbin/splash_sync Nov 6 13:27:02 wk-001 user.notice fsm: Node is online Nov 6 13:27:08 wk-001 daemon.info n2n[32231]: Registering with supernode Nov 6 13:27:08 wk-001 daemon.info n2n[32231]: Received REGISTER_ACK from remote peer [ip=88.152.235.101:56789] Nov 6 13:27:09 wk-001 daemon.info n2n[32257]: Registering with supernode Nov 6 13:27:41 wk-001 authpriv.info dropbear[344]: Child connection from 10.52.3.240:35281 Nov 6 13:28:01 wk-001 cron.info crond[1592]: crond: USER root pid 345 cmd /sbin/p2ptbl gossip /tmp/p2ptbl/gwip 500 br-mesh Nov 6 13:28:01 wk-001 cron.info crond[1592]: crond: USER root pid 347 cmd /sbin/p2ptbl gossip /tmp/p2ptbl/splash 500 br-mesh Nov 6 13:28:01 wk-001 cron.info crond[1592]: crond: USER root pid 348 cmd /sbin/fsm watch inetable Nov 6 13:28:01 wk-001 cron.info crond[1592]: crond: USER root pid 349 cmd /sbin/splash_sync Nov 6 13:28:02 wk-001 user.notice fsm: Node is online Nov 6 13:28:08 wk-001 daemon.info n2n[32231]: Registering with supernode Nov 6 13:28:08 wk-001 daemon.info n2n[32231]: Received REGISTER_ACK from remote peer [ip=88.152.235.101:56789] Nov 6 13:28:09 wk-001 daemon.info n2n[32257]: Registering with supernode Nov 6 13:28:09 wk-001 authpriv.notice dropbear[344]: Password auth succeeded for 'root' from 10.52.3.240:35281 Nov 6 13:28:09 wk-001 daemon.info n2n[32257]: Received REGISTER_ACK from remote peer [ip=78.47.181.173:31337]

lcb01a commented 11 years ago

Diese Logs sind nicht aussagekräftig. Für Splash-Fehler bitte immer die Logfile /tmp/www.log.splash_click.html anhängen.

RubenKelevra commented 11 years ago

Alles klar, sobald der Fehler nochmals auftritt häng ich ein Logfile an.

RubenKelevra commented 11 years ago

Ich hab mich gerade zum Freifunkknoten verbunden und bekomm mit meinem Notebook keine Internetverbindung freigeschaltet:

root@wk-001:/tmp# cat www.log.splash_click.html

urldecode+ sed s/target_url=//g
URL=http://www.freifunk-rheinland.net/
awk BEGIN { FS = " " } ; { print $4 }
grep ^10.52.0.240
USER_MAC=38:59:f9:6b:9c:07
[ -n 38:59:f9:6b:9c:07 ]
p2ptbl get /tmp/p2ptbl/splash 38:59:f9:6b:9c:07
[ -z 1353294057 ]
add_splash_p2ptbl 38:59:f9:6b:9c:07
date +%s
p2ptbl update /tmp/p2ptbl/splash 38:59:f9:6b:9c:07 1353294062 br-mesh tr: short write
echo -en Status: 200 OK\r Content-Type: text/html\r \r
have_internet
[ -z ]
cat /tmp/fsm/inetable
local mode=queen
[ queen == drone -o queen == queen -o queen == ghost ]
have_internet_cached_result=true
true
sed s#/#\/#g
echo http://www.freifunk-rheinland.net/
sed s/targeturl/http:\/\/www.freifunk-rheinland.net\//g iframe.html

lcb01a commented 11 years ago

Hi Ruben,

Anscheinend hast du noch die Version mit dem p2ptable Splash, bitte verwende die aktuelle Version von http://freifunk.fnordeingang.de/images/fsm/2012-10-30_git-c9d4715/

Diese dürfte besser funktionieren! :)

Gruß Linus

RubenKelevra commented 11 years ago

Scheint gefixt zu sein. Ist nicht wieder aufgetreten. :)

FreifunkAdvanced / ff-advanced

Problem beim Freischalten des Internets #48