On Sun, Jul 27, 2014 at 3:34 PM, Weedy <weedy2...@gmail.com> wrote: > Something I discovered while dealing with the WAN bouncing problem. > If you ifdown while pppd is setting up it pukes. > > Sat Jul 26 02:41:52 2014 kern.info kernel: [ 23.080000] IPv6: > ADDRCONF(NETDEV_UP): wlan0: link is not ready > Sat Jul 26 02:41:53 2014 kern.info kernel: [ 23.110000] device wlan0 > entered promiscuous mode > Sat Jul 26 02:41:53 2014 kern.info kernel: [ 23.110000] br-lan: port > 3(wlan0) entered forwarding state > Sat Jul 26 02:41:53 2014 kern.info kernel: [ 23.120000] br-lan: port > 3(wlan0) entered forwarding state > Sat Jul 26 02:41:53 2014 kern.info kernel: [ 23.780000] eth0: link down > Sat Jul 26 02:41:53 2014 kern.info kernel: [ 23.810000] br-lan: port > 3(wlan0) entered disabled state > Sat Jul 26 02:41:53 2014 kern.info kernel: [ 23.810000] br-lan: port > 1(eth0.1) entered disabled state > Sat Jul 26 02:41:53 2014 daemon.notice netifd: Network device 'eth0' > link is down > Sat Jul 26 02:41:53 2014 daemon.notice netifd: VLAN 'eth0.2' link is down > Sat Jul 26 02:41:53 2014 daemon.notice netifd: Interface 'wan' has > link connectivity loss > Sat Jul 26 02:41:53 2014 daemon.notice netifd: VLAN 'eth0.1' link is down > Sat Jul 26 02:41:54 2014 kern.info kernel: [ 24.650000] eth0: link > up (1000Mbps/Full duplex) > Sat Jul 26 02:41:54 2014 kern.info kernel: [ 24.650000] br-lan: port > 1(eth0.1) entered forwarding state > Sat Jul 26 02:41:54 2014 kern.info kernel: [ 24.660000] br-lan: port > 1(eth0.1) entered forwarding state > Sat Jul 26 02:41:54 2014 daemon.notice netifd: Network device 'eth0' link is > up > Sat Jul 26 02:41:54 2014 daemon.notice netifd: VLAN 'eth0.2' link is up > Sat Jul 26 02:41:54 2014 daemon.notice netifd: Interface 'wan' has > link connectivity > Sat Jul 26 02:41:54 2014 daemon.notice netifd: VLAN 'eth0.1' link is up > Sat Jul 26 02:41:55 2014 kern.info kernel: [ 25.260000] br-lan: port > 2(wlan1) entered forwarding state > Sat Jul 26 02:41:55 2014 kern.info kernel: [ 25.260000] br-lan: port > 2(wlan1) entered forwarding state > Sat Jul 26 02:41:55 2014 kern.info kernel: [ 25.270000] IPv6: > ADDRCONF(NETDEV_CHANGE): wlan1: link becomes ready > Sat Jul 26 02:41:55 2014 kern.info kernel: [ 25.300000] br-lan: port > 3(wlan0) entered forwarding state > Sat Jul 26 02:41:55 2014 kern.info kernel: [ 25.310000] br-lan: port > 3(wlan0) entered forwarding state > Sat Jul 26 02:41:55 2014 kern.info kernel: [ 25.310000] IPv6: > ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready > Sat Jul 26 02:41:55 2014 user.emerg syslog: setting up led USB1 > Sat Jul 26 02:41:55 2014 user.emerg syslog: setting up led USB2 > Sat Jul 26 02:41:55 2014 user.emerg syslog: setting up led WLAN2G > Sat Jul 26 02:41:55 2014 daemon.notice netifd: Network device 'wlan1' link is > up > Sat Jul 26 02:41:55 2014 daemon.notice netifd: Network device 'wlan0' link is > up > Sat Jul 26 02:41:56 2014 user.emerg syslog: - init complete - > Sat Jul 26 02:41:56 2014 kern.info kernel: [ 26.660000] br-lan: port > 1(eth0.1) entered forwarding state > Sat Jul 26 02:41:57 2014 kern.info kernel: [ 27.260000] br-lan: port > 2(wlan1) entered forwarding state > Sat Jul 26 02:41:57 2014 kern.info kernel: [ 27.310000] br-lan: port > 3(wlan0) entered forwarding state > Sat Jul 26 02:41:58 2014 daemon.info dnsmasq[1696]: started, version > 2.71 cachesize 4096 > Sat Jul 26 02:41:58 2014 daemon.info dnsmasq[1696]: compile time > options: IPv6 GNU-getopt no-DBus no-i18n no-IDN DHCP no-DHCPv6 no-Lua > TFTP no-conntrack no-ipset no-auth no-DNSSEC > Sat Jul 26 02:41:58 2014 daemon.info dnsmasq-dhcp[1696]: DHCP, IP > range 192.168.8.150 -- 192.168.8.199, lease time 3h > Sat Jul 26 02:41:58 2014 daemon.info dnsmasq[1696]: using local > addresses only for domain lan > Sat Jul 26 02:41:58 2014 daemon.info dnsmasq[1696]: reading > /etc/resolv.conf.opendns > Sat Jul 26 02:41:58 2014 daemon.info dnsmasq[1696]: using local > addresses only for domain lan > Sat Jul 26 02:41:58 2014 daemon.info dnsmasq[1696]: using nameserver > 66.163.0.161#53 > Sat Jul 26 02:41:58 2014 daemon.info dnsmasq[1696]: using nameserver > 206.248.154.170#53 > Sat Jul 26 02:41:58 2014 daemon.info dnsmasq[1696]: using nameserver > 206.248.154.22#53 > Sat Jul 26 02:41:58 2014 daemon.info dnsmasq[1696]: using nameserver > 8.8.4.4#53 > Sat Jul 26 02:41:58 2014 daemon.info dnsmasq[1696]: read /etc/hosts - > 5 addresses > Sat Jul 26 02:41:58 2014 daemon.info dnsmasq-dhcp[1696]: read > /etc/ethers - 13 addresses > Sat Jul 26 02:41:59 2014 user.notice firewall: Reloading firewall due > to ifup of lan (br-lan) > Sat Jul 26 02:42:00 2014 user.notice upnp daemon: external interface > not found, not starting > Sat Jul 26 02:42:01 2014 cron.info crond[861]: crond: USER root pid > 1857 cmd /bin/sh /etc/netCheck.sh > Sat Jul 26 02:42:01 2014 daemon.info pppd[1107]: PPP session is 5594 > Sat Jul 26 02:42:01 2014 daemon.warn pppd[1107]: Connected to > 00:90:1a:a3:b7:45 via interface eth0.2 > Sat Jul 26 02:42:01 2014 daemon.info pppd[1107]: Using interface pppoe-wan > Sat Jul 26 02:42:01 2014 daemon.notice pppd[1107]: Connect: pppoe-wan > <--> eth0.2 > Sat Jul 26 02:42:02 2014 daemon.info pppd[1107]: Remote message: lcp > tunnel failed > Sat Jul 26 02:42:02 2014 daemon.err pppd[1107]: PAP authentication failed > Sat Jul 26 02:42:02 2014 daemon.notice pppd[1107]: Connection terminated. > Sat Jul 26 02:42:02 2014 daemon.info pppd[1107]: Exit. > Sat Jul 26 02:42:02 2014 daemon.notice netifd: Interface 'wan' is now down > Sat Jul 26 02:42:02 2014 kern.info kernel: [ 32.490000] IPv6: > ADDRCONF(NETDEV_UP): eth0.2: link is not ready > Sat Jul 26 02:42:02 2014 daemon.notice netifd: Interface 'wan' is disabled > Sat Jul 26 02:42:02 2014 daemon.notice netifd: Interface 'wan' is enabled > Sat Jul 26 02:42:02 2014 daemon.notice netifd: Interface 'wan' is setting up > now > Sat Jul 26 02:42:02 2014 daemon.notice netifd: VLAN 'eth0.2' link is down > Sat Jul 26 02:42:02 2014 daemon.notice netifd: Interface 'wan' has > link connectivity loss > Sat Jul 26 02:42:02 2014 daemon.notice netifd: VLAN 'eth0.2' link is up > Sat Jul 26 02:42:02 2014 daemon.notice netifd: Interface 'wan' has > link connectivity > Sat Jul 26 02:42:02 2014 daemon.info pppd[1942]: Plugin rp-pppoe.so loaded. > Sat Jul 26 02:42:02 2014 daemon.info pppd[1942]: RP-PPPoE plugin > version 3.8p compiled against pppd 2.4.6 > Sat Jul 26 02:42:02 2014 daemon.notice pppd[1942]: pppd 2.4.6 started > by root, uid 0 > Sat Jul 26 02:42:03 2014 user.notice netCheck: Something is funky with > the firewall, resetting it. > Sat Jul 26 02:42:07 2014 daemon.info pppd[1942]: PPP session is 5605 > Sat Jul 26 02:42:07 2014 daemon.warn pppd[1942]: Connected to > 00:90:1a:a3:b7:45 via interface eth0.2 > Sat Jul 26 02:42:07 2014 daemon.info pppd[1942]: Using interface pppoe-wan > Sat Jul 26 02:42:07 2014 daemon.notice pppd[1942]: Connect: pppoe-wan > <--> eth0.2 > Sat Jul 26 02:42:08 2014 daemon.info pppd[1942]: Remote message: lcp > tunnel failed > Sat Jul 26 02:42:08 2014 daemon.err pppd[1942]: PAP authentication failed > Sat Jul 26 02:42:08 2014 daemon.notice pppd[1942]: Connection terminated. > Sat Jul 26 02:42:08 2014 daemon.info pppd[1942]: Exit. > Sat Jul 26 02:42:08 2014 daemon.notice netifd: Interface 'wan' is now down > Sat Jul 26 02:42:08 2014 daemon.notice netifd: Interface 'wan' is disabled > Sat Jul 26 02:42:08 2014 daemon.notice netifd: Interface 'wan' is enabled > Sat Jul 26 02:42:08 2014 daemon.notice netifd: Interface 'wan' is setting up > now > Sat Jul 26 02:42:08 2014 daemon.notice netifd: VLAN 'eth0.2' link is down > Sat Jul 26 02:42:08 2014 daemon.notice netifd: Interface 'wan' has > link connectivity loss > Sat Jul 26 02:42:08 2014 daemon.notice netifd: VLAN 'eth0.2' link is up > Sat Jul 26 02:42:08 2014 daemon.notice netifd: Interface 'wan' has > link connectivity > Sat Jul 26 02:42:08 2014 kern.info kernel: [ 38.700000] IPv6: > ADDRCONF(NETDEV_UP): eth0.2: link is not ready > Sat Jul 26 02:42:08 2014 daemon.info pppd[2069]: Plugin rp-pppoe.so loaded. > Sat Jul 26 02:42:08 2014 daemon.info pppd[2069]: RP-PPPoE plugin > version 3.8p compiled against pppd 2.4.6 > Sat Jul 26 02:42:08 2014 daemon.notice pppd[2069]: pppd 2.4.6 started > by root, uid 0 > Sat Jul 26 02:48:11 2014 user.notice netCheck: Number of external > hosts unavalible: 4 > Sat Jul 26 02:48:11 2014 user.notice netCheck: Restarting WAN > Sat Jul 26 02:48:14 2014 daemon.info pppd[2069]: PPP session is 5609 > Sat Jul 26 02:48:14 2014 daemon.warn pppd[2069]: Connected to > 00:90:1a:a3:b7:45 via interface eth0.2 > Sat Jul 26 02:48:14 2014 daemon.info pppd[2069]: Using interface pppoe-wan > Sat Jul 26 02:48:14 2014 daemon.notice pppd[2069]: Connect: pppoe-wan > <--> eth0.2 > Sat Jul 26 02:48:14 2014 daemon.info pppd[2069]: System time change detected. > Sat Jul 26 02:48:14 2014 daemon.info pppd[2069]: Terminating on signal 15 > Sat Jul 26 02:48:17 2014 daemon.notice netifd: Interface 'wan' is now down > Sat Jul 26 02:48:17 2014 kern.info kernel: [ 47.160000] IPv6: > ADDRCONF(NETDEV_UP): eth0.2: link is not ready > Sat Jul 26 02:48:17 2014 kern.alert kernel: [ 47.170000] CPU 0 > Unable to handle kernel paging request at virtual address 00000204, > epc == 871277e4, ra == 871277a4 > Sat Jul 26 02:48:17 2014 kern.warn kernel: [ 47.170000] Oops[#1]: > Sat Jul 26 02:48:17 2014 kern.warn kernel: [ 47.170000] CPU: 0 PID: > 2069 Comm: pppd Not tainted 3.10.44 #2 > Sat Jul 26 02:48:17 2014 kern.warn kernel: [ 47.170000] task: > 86e125b0 ti: 86df2000 task.ti: 86df2000 > Sat Jul 26 02:48:17 2014 kern.warn kernel: [ 47.170000] $ 0 : > 00000000 00000001 00000001 00000000 > Sat Jul 26 02:48:17 2014 kern.warn kernel: [ 47.170000] $ 4 : > 864dac00 00000000 86e448c8 00000001 > Sat Jul 26 02:48:17 2014 kern.warn kernel: [ 47.170000] $ 8 : > 0010003d 0010003d 00000001 87548550 > Sat Jul 26 02:48:17 2014 kern.warn kernel: [ 47.170000] $12 : > 00000000 00000001 000f003d 8704cf74 > Sat Jul 26 02:48:17 2014 kern.warn kernel: [ 47.170000] $16 : > 864dac00 00000000 87543580 875435a0 > Sat Jul 26 02:48:17 2014 kern.warn kernel: [ 47.170000] $20 : > 86e448c8 875435a0 87807330 80310000 > Sat Jul 26 02:48:17 2014 kern.warn kernel: [ 47.170000] $24 : > 00000000 801ef6f0 > Sat Jul 26 02:48:17 2014 kern.warn kernel: [ 47.170000] $28 : > 86df2000 86df3cf0 802c6fd8 871277a4 > Sat Jul 26 02:48:17 2014 kern.warn kernel: [ 47.170000] Hi : 00000015 > Sat Jul 26 02:48:17 2014 kern.warn kernel: [ 47.170000] Lo : 00000006 > Sat Jul 26 02:48:17 2014 kern.warn kernel: [ 47.170000] epc : > 871277e4 0x871277e4 > Sat Jul 26 02:48:17 2014 kern.warn kernel: [ 47.170000] Not tainted > Sat Jul 26 02:48:17 2014 kern.warn kernel: [ 47.170000] ra : > 871277a4 0x871277a4 > Sat Jul 26 02:48:17 2014 kern.warn kernel: [ 47.170000] Status: > 1100dc02 KERNEL EXL > Sat Jul 26 02:48:17 2014 kern.warn kernel: [ 47.170000] Cause : 00800008 > Sat Jul 26 02:48:17 2014 kern.warn kernel: [ 47.170000] BadVA : 00000204 > Sat Jul 26 02:48:17 2014 kern.warn kernel: [ 47.170000] PrId : > 0001974c (MIPS 74Kc) > Sat Jul 26 02:48:17 2014 kern.warn kernel: [ 47.170000] Modules > linked in: ath9k ath9k_common pppoe ppp_async iptable_nat ath9k_hw ath > pppox ppp_generic nf_nat_ipv4 nf_conntrack_ipv4 mac80211 > ipt_MASQUERADE cfg80211 xt_time xt_tcpudp xt_tcpmss xt_string > xt_statistic xt_state xt_recent xt_nat xt_multiport xt_mark xt_mac > xt_limit xt_length xt_hl xt_helper xt_ecn xt_dscp xt_conntrack > xt_connmark xt_connlimit xt_connbytes xt_comment xt_TCPMSS xt_REDIRECT > xt_LOG xt_HL xt_DSCP xt_CT xt_CLASSIFY ts_kmp ts_fsm tSat Jul 26 > 02:48:17 2014 kern.warn kernel: [ 47.170000] Process pppd (pid: > 2069, threadinfo=86df2000, task=86e125b0, tls=77c51440) > Sat Jul 26 02:48:17 2014 kern.warn kernel: [ 47.170000] Stack : > 87543440 800fa754 87543420 8025ef94 875485d8 87543580 87127cc4 > 875484c8 > Sat Jul 26 02:48:17 2014 kern.warn kernel: [ 47.170000] > 875435a0 86e448c8 875435a0 801ef85c 86d84480 86539c80 875485d8 > 00000000 > Sat Jul 26 02:48:17 2014 kern.warn kernel: [ 47.170000] > 86e448c0 86e448c0 00000008 801ef908 86e448c8 875435a0 86e448c0 > 00000008 > Sat Jul 26 02:48:17 2014 kern.warn kernel: [ 47.170000] > 875484c8 800e66cc 810d3b80 86e440a0 00000000 800e30f4 00000000 > 00000000 > Sat Jul 26 02:48:17 2014 kern.warn kernel: [ 47.170000] > 86e125b0 86e44820 80380000 86d844bc 802c6fc8 00000001 80320000 > 800902a8 > Sat Jul 26 02:48:17 2014 kern.warn kernel: [ 47.170000] ... > Sat Jul 26 02:48:17 2014 kern.warn kernel: [ 47.170000] Call Trace: > Sat Jul 26 02:48:17 2014 kern.warn kernel: [ 47.170000] [<871277e4>] > 0x871277e4 > Sat Jul 26 02:48:17 2014 kern.warn kernel: [ 47.170000] > Sat Jul 26 02:48:17 2014 kern.warn kernel: [ 47.170000] > Sat Jul 26 02:48:17 2014 kern.warn kernel: [ 47.170000] Code: > 41626000 30420001 000000c0 <8c630204> 8c640000 2484ffff ac640000 > 10400002 41606000 > Sat Jul 26 02:48:17 2014 kern.warn kernel: [ 47.420000] ---[ end > trace f3d54a54d90270c9 ]--- > Sat Jul 26 02:48:17 2014 kern.alert kernel: [ 47.430000] Fixing > recursive fault but reboot is needed! > Sat Jul 26 02:48:17 2014 daemon.notice netifd: Interface 'wan' is disabled > Sat Jul 26 02:48:17 2014 daemon.notice netifd: Interface 'wan' is enabled > Sat Jul 26 02:48:17 2014 daemon.notice netifd: Interface 'wan' is setting up > now > Sat Jul 26 02:48:17 2014 daemon.notice netifd: VLAN 'eth0.2' link is down > Sat Jul 26 02:48:17 2014 daemon.notice netifd: Interface 'wan' has > link connectivity loss > Sat Jul 26 02:48:17 2014 daemon.notice netifd: VLAN 'eth0.2' link is up > Sat Jul 26 02:48:17 2014 daemon.notice netifd: Interface 'wan' has > link connectivity > Sat Jul 26 02:48:17 2014 daemon.info pppd[2174]: Plugin rp-pppoe.so loaded. > Sat Jul 26 02:48:17 2014 daemon.info pppd[2174]: RP-PPPoE plugin > version 3.8p compiled against pppd 2.4.6 > Sat Jul 26 02:48:17 2014 daemon.notice pppd[2174]: pppd 2.4.6 started > by root, uid 0 > Sat Jul 26 02:48:17 2014 daemon.info pppd[2174]: PPP session is 5611 > Sat Jul 26 02:48:17 2014 daemon.warn pppd[2174]: Connected to > 00:90:1a:a3:b7:45 via interface eth0.2 > Sat Jul 26 02:48:17 2014 daemon.err pppd[2174]: Couldn't rename ppp1 > to pppoe-wan > Sat Jul 26 02:48:17 2014 daemon.info pppd[2174]: Exit.
bump _______________________________________________ openwrt-devel mailing list openwrt-devel@lists.openwrt.org https://lists.openwrt.org/cgi-bin/mailman/listinfo/openwrt-devel
