#21319: TP-Link TD-W8970 VSDL problem
--------------------------+---------------------------------------
Reporter: d.buffa@… | Owner: developers
Type: defect | Status: new
Priority: high | Milestone: Designated Driver (Trunk)
Component: base system | Version: Trunk
Resolution: | Keywords:
--------------------------+---------------------------------------
Comment (by d.buffa@…):
Ok,
today i did a usefull test session. First of all I have to confirm that
the DSL sync problem on trunk was the firmware, I have done a new build
selecting dsl-vrx200-firmware-xdsl-a firmware and now DSL sync is ok. This
is the output of /etc/init.d/dsl_control status command
{{{
ATU-C Vendor ID: B5,00,42,44,43,4D,A4,15
ATU-C System Vendor ID: B5,00,42,44,43,4D,00,00
Chipset: Lantiq-VRX200 Unknown
Firmware Version: 5.7.4.3.0.6
API Version: 4.16.6.3
XTSE Capabilities: 0x0, 0x0, 0x0, 0x0, 0x0, 0x0,
0x0, 0x2
Annex: B
Line Mode: G.993.2 (VDSL2)
Line State: UP [0x801: showtime_tc_sync]
Forward Error Correction Seconds (FECS): Near: / Far:
Errored seconds (ES): Near: 0 / Far: 14
Severely Errored Seconds (SES): Near: 0 / Far: 0
Loss of Signal Seconds (LOSS): Near: 0 / Far: 0
Unavailable Seconds (UAS): Near: 42 / Far: 42
Header Error Code Errors (HEC): Near: 0 / Far: 0
Non Pre-emtive CRC errors (CRC_P): Near: 0 / Far: 0
Pre-emtive CRC errors (CRCP_P): Near: 0 / Far: 0
Power Management Mode: L0 - Synchronized
Latency / Interleave Delay: Down: Interleave (0.15 ms) / Up:
Interleave (7.0 ms)
Data Rate: Down: 53.449 Mb/s / Up: 10.799
Mb/s
Line Attenuation (LATN): Down: 7.8dB / Up: 8.0dB
Signal Attenuation (SATN): Down: 7.8dB / Up: 6.4dB
Noise Margin (SNR): Down: 25.6dB / Up: 17.1dB
Aggregate Transmit Power(ACTATP): Down: -23.-2dB / Up: 11.3dB
Max. Attainable Data Rate (ATTNDR): Down: 114.696 Mb/s / Up: 28.587
Mb/s
Line Uptime Seconds: 0
Line Uptime: down
}}}
The log says that DSL line is annex b (and it's strange, I'm in Italy and
here annex is a), anyway i tried also with annex b firmare obtaining the
same result...
I still have the wan not connected problem, althought system log says that
pppoe negotiation is ok
{{{
Mon Dec 7 17:27:22 2015 kern.info kernel: [ 105.325049] device ptm0
entered promiscuous mode
Mon Dec 7 17:27:22 2015 daemon.notice netifd: Interface 'wan' is enabled
Mon Dec 7 17:27:22 2015 daemon.notice netifd: Interface 'wan' is setting
up now
Mon Dec 7 17:27:23 2015 daemon.info pppd[4017]: Plugin rp-pppoe.so
loaded.
Mon Dec 7 17:27:23 2015 daemon.info pppd[4017]: RP-PPPoE plugin version
3.8p compiled against pppd 2.4.7
Mon Dec 7 17:27:23 2015 daemon.notice pppd[4017]: pppd 2.4.7 started by
root, uid 0
Mon Dec 7 17:27:28 2015 daemon.info pppd[4017]: PPP session is 1537
Mon Dec 7 17:27:28 2015 daemon.warn pppd[4017]: Connected to
88:a2:5e:17:be:be via interface ptm0.835
Mon Dec 7 17:27:28 2015 kern.info kernel: [ 110.947277] pppoe-wan:
renamed from ppp0
Mon Dec 7 17:27:28 2015 daemon.info pppd[4017]: Using interface pppoe-wan
Mon Dec 7 17:27:28 2015 daemon.notice pppd[4017]: Connect: pppoe-wan <-->
ptm0.835
Mon Dec 7 17:27:28 2015 daemon.notice pppd[4017]: PAP authentication
succeeded
Mon Dec 7 17:27:28 2015 daemon.notice pppd[4017]: peer from calling
number 88:A2:5E:17:BE:BE authorized
Mon Dec 7 17:27:28 2015 daemon.notice netifd: Network device 'pppoe-wan'
link is up
Mon Dec 7 17:27:28 2015 daemon.notice netifd: Interface 'wan6' has link
connectivity
Mon Dec 7 17:27:28 2015 daemon.notice pppd[4017]: local IP address
95.238.236.181
Mon Dec 7 17:27:28 2015 daemon.notice pppd[4017]: remote IP address
192.168.100.1
Mon Dec 7 17:27:28 2015 daemon.notice pppd[4017]: primary DNS address
85.37.17.17
Mon Dec 7 17:27:28 2015 daemon.notice pppd[4017]: secondary DNS address
85.38.28.72
Mon Dec 7 17:27:28 2015 daemon.notice pppd[4017]: local LL address
fe80::2836:e976:182d:2f96
Mon Dec 7 17:27:28 2015 daemon.notice pppd[4017]: remote LL address
fe80::02a0:a50f:fc86:8004
Mon Dec 7 17:27:28 2015 daemon.info pppd[4017]: IPV6CP terminated by peer
Mon Dec 7 17:27:29 2015 daemon.notice netifd: Interface 'wan6' is enabled
Mon Dec 7 17:27:29 2015 daemon.notice netifd: Interface 'wan6' is setting
up now
Mon Dec 7 17:27:29 2015 daemon.notice netifd: Interface 'wan' is now up
Mon Dec 7 17:27:29 2015 daemon.info dnsmasq[1376]: reading
/tmp/resolv.conf.auto
Mon Dec 7 17:27:29 2015 daemon.info dnsmasq[1376]: using local addresses
only for domain lan
Mon Dec 7 17:27:29 2015 daemon.info dnsmasq[1376]: using nameserver
85.37.17.17#53
Mon Dec 7 17:27:29 2015 daemon.info dnsmasq[1376]: using nameserver
85.38.28.72#53
Mon Dec 7 17:27:29 2015 daemon.notice netifd: Network alias 'pppoe-wan'
link is up
Mon Dec 7 17:27:29 2015 daemon.notice netifd: Interface 'wan_6' is
enabled
Mon Dec 7 17:27:29 2015 daemon.notice netifd: Interface 'wan_6' has link
connectivity
Mon Dec 7 17:27:29 2015 daemon.notice netifd: Interface 'wan_6' is
setting up now
Mon Dec 7 17:27:29 2015 daemon.info dnsmasq[1376]: reading
/tmp/resolv.conf.auto
Mon Dec 7 17:27:29 2015 daemon.info dnsmasq[1376]: using local addresses
only for domain lan
Mon Dec 7 17:27:29 2015 daemon.info dnsmasq[1376]: using nameserver
85.37.17.17#53
Mon Dec 7 17:27:29 2015 daemon.info dnsmasq[1376]: using nameserver
85.38.28.72#53
Mon Dec 7 17:27:29 2015 daemon.info dnsmasq[1376]: using nameserver
85.37.17.17#53
Mon Dec 7 17:27:29 2015 daemon.info dnsmasq[1376]: using nameserver
85.38.28.72#53
Mon Dec 7 17:27:29 2015 daemon.notice netifd: Interface 'wan' has lost
the connection
Mon Dec 7 17:27:29 2015 daemon.warn dnsmasq[1376]: no servers found in
/tmp/resolv.conf.auto, will retry
Mon Dec 7 17:27:29 2015 daemon.notice netifd: Interface 'wan_6' is now
down
Mon Dec 7 17:27:29 2015 daemon.notice netifd: Interface 'wan_6' is
disabled
Mon Dec 7 17:27:29 2015 daemon.notice netifd: Interface 'wan_6' has link
connectivity loss
Mon Dec 7 17:27:30 2015 user.notice firewall: Reloading firewall due to
ifup of wan (pppoe-wan)
}}}
There is also the strange log "Interface 'wan' has lost the connection"
after pppoe successfully negotiation...
This is interface situation
{{{
br-lan Link encap:Ethernet HWaddr 30:B5:C2:92:DA:32
inet addr:172.20.0.1 Bcast:172.20.0.255 Mask:255.255.255.0
inet6 addr: fe80::32b5:c2ff:fe92:da32%1998147896/64 Scope:Link
inet6 addr: fd09:c3f8:a1ec::1%1998147896/60 Scope:Global
UP BROADCAST RUNNING MULTICAST MTU:1500 Metric:1
RX packets:4137 errors:0 dropped:0 overruns:0 frame:0
TX packets:2893 errors:0 dropped:0 overruns:0 carrier:0
collisions:0 txqueuelen:0
RX bytes:305090 (297.9 KiB) TX bytes:676987 (661.1 KiB)
eth0 Link encap:Ethernet HWaddr 30:B5:C2:92:DA:32
inet6 addr: fe80::32b5:c2ff:fe92:da32%1997481144/64 Scope:Link
UP BROADCAST RUNNING MULTICAST MTU:1500 Metric:1
RX packets:4628 errors:0 dropped:12 overruns:0 frame:0
TX packets:2902 errors:0 dropped:0 overruns:0 carrier:0
collisions:0 txqueuelen:1000
RX bytes:463394 (452.5 KiB) TX bytes:703327 (686.8 KiB)
eth0.1 Link encap:Ethernet HWaddr 30:B5:C2:92:DA:32
UP BROADCAST RUNNING MULTICAST MTU:1500 Metric:1
RX packets:4377 errors:0 dropped:0 overruns:0 frame:0
TX packets:2889 errors:0 dropped:0 overruns:0 carrier:0
collisions:0 txqueuelen:0
RX bytes:325000 (317.3 KiB) TX bytes:676255 (660.4 KiB)
lo Link encap:Local Loopback
inet addr:127.0.0.1 Mask:255.0.0.0
inet6 addr: ::1%4566360/128 Scope:Host
UP LOOPBACK RUNNING MTU:65536 Metric:1
RX packets:276 errors:0 dropped:0 overruns:0 frame:0
TX packets:276 errors:0 dropped:0 overruns:0 carrier:0
collisions:0 txqueuelen:0
RX bytes:18700 (18.2 KiB) TX bytes:18700 (18.2 KiB)
pppoe-wan Link encap:Point-to-Point Protocol
inet addr:79.27.218.2 P-t-P:192.168.100.1 Mask:255.255.255.255
UP POINTOPOINT RUNNING NOARP MULTICAST MTU:1492 Metric:1
RX packets:33 errors:0 dropped:0 overruns:0 frame:0
TX packets:11 errors:0 dropped:2 overruns:0 carrier:0
collisions:0 txqueuelen:3
RX bytes:1697 (1.6 KiB) TX bytes:490 (490.0 B)
ptm0 Link encap:Ethernet HWaddr 00:20:DA:86:23:75
inet6 addr: fe80::220:daff:fe86:2375%1997482008/64 Scope:Link
UP BROADCAST RUNNING MULTICAST MTU:1500 Metric:1
RX packets:451 errors:0 dropped:0 overruns:0 frame:0
TX packets:453 errors:0 dropped:66 overruns:0 carrier:0
collisions:0 txqueuelen:1000
RX bytes:28085 (27.4 KiB) TX bytes:29657 (28.9 KiB)
ptm0.835 Link encap:Ethernet HWaddr 30:B5:C2:92:DA:33
inet6 addr: fe80::32b5:c2ff:fe92:da33%1998147608/64 Scope:Link
UP BROADCAST RUNNING MULTICAST MTU:1500 Metric:1
RX packets:199 errors:0 dropped:0 overruns:0 frame:0
TX packets:184 errors:0 dropped:0 overruns:0 carrier:0
collisions:0 txqueuelen:0
RX bytes:9059 (8.8 KiB) TX bytes:6490 (6.3 KiB)
}}}
This is the routing table
{{{
Kernel IP routing table
Destination Gateway Genmask Flags Metric Ref Use
Iface
172.20.0.0 * 255.255.255.0 U 0 0 0
br-lan
192.168.100.1 * 255.255.255.255 UH 0 0 0
pppoe-wan
}}}
and obviously in this situation I cannot contact any hosts of the wan side
{{{
root@OpenWrt:~# ping 8.8.8.8
PING 8.8.8.8 (8.8.8.8): 56 data bytes
ping: sendto: Network unreachable
}}}
but if I force the use of pppoe-wan interface I can ping successfully
{{{
root@OpenWrt:~# ping -I pppoe-wan 8.8.8.8
PING 8.8.8.8 (8.8.8.8): 56 data bytes
64 bytes from 8.8.8.8: seq=0 ttl=57 time=25.602 ms
64 bytes from 8.8.8.8: seq=1 ttl=57 time=25.614 ms
64 bytes from 8.8.8.8: seq=2 ttl=57 time=25.442 ms
64 bytes from 8.8.8.8: seq=3 ttl=57 time=25.512 ms
^C
--- 8.8.8.8 ping statistics ---
4 packets transmitted, 4 packets received, 0% packet loss
round-trip min/avg/max = 25.442/25.542/25.614 ms
root@OpenWrt:~#
}}}
So DSL is ok, I have ISP connection on the wan side of the router but
there is something wrong downstream pppoe negotiation...
This is the complete kernel log
{{{
[ 0.000000] Linux version 4.1.13 ([email protected]) (gcc
version 5.2.0 (OpenWrt GCC 5.2.0 r47680) ) #3 Mon Dec 7 18:17:45 CET 2015
[ 0.000000] SoC: VR9 rev 1.2
[ 0.000000] bootconsole [early0] enabled
[ 0.000000] CPU0 revision is: 00019556 (MIPS 34Kc)
[ 0.000000] MIPS: machine is TDW8970 - TP-LINK TD-W8970
[ 0.000000] Determined physical RAM map:
[ 0.000000] memory: 04000000 @ 00000000 (usable)
[ 0.000000] Initrd not found or empty - disabling initrd
[ 0.000000] Zone ranges:
[ 0.000000] Normal [mem 0x0000000000000000-0x0000000003ffffff]
[ 0.000000] Movable zone start for each node
[ 0.000000] Early memory node ranges
[ 0.000000] node 0: [mem 0x0000000000000000-0x0000000003ffffff]
[ 0.000000] Initmem setup node 0 [mem
0x0000000000000000-0x0000000003ffffff]
[ 0.000000] On node 0 totalpages: 16384
[ 0.000000] free_area_init_node: node 0, pgdat 804b1e00, node_mem_map
810078c0
[ 0.000000] Normal zone: 128 pages used for memmap
[ 0.000000] Normal zone: 0 pages reserved
[ 0.000000] Normal zone: 16384 pages, LIFO batch:3
[ 0.000000] Primary instruction cache 32kB, VIPT, 4-way, linesize 32
bytes.
[ 0.000000] Primary data cache 32kB, 4-way, VIPT, cache aliases,
linesize 32 bytes
[ 0.000000] pcpu-alloc: s0 r0 d32768 u32768 alloc=1*32768
[ 0.000000] pcpu-alloc: [0] 0
[ 0.000000] Built 1 zonelists in Zone order, mobility grouping on.
Total pages: 16256
[ 0.000000] Kernel command line: console=ttyLTQ0,115200
init=/etc/preinit
[ 0.000000] PID hash table entries: 256 (order: -2, 1024 bytes)
[ 0.000000] Dentry cache hash table entries: 8192 (order: 3, 32768
bytes)
[ 0.000000] Inode-cache hash table entries: 4096 (order: 2, 16384
bytes)
[ 0.000000] Writing ErrCtl register=00060a20
[ 0.000000] Readback ErrCtl register=00060a20
[ 0.000000] Memory: 59556K/65536K available (3771K kernel code, 150K
rwdata, 988K rodata, 188K init, 207K bss, 5980K reserved, 0K cma-reserved)
[ 0.000000] NR_IRQS:256
[ 0.000000] CPU Clock: 500MHz
[ 0.000000] clocksource MIPS: mask: 0xffffffff max_cycles: 0xffffffff,
max_idle_ns: 7645041786 ns
[ 0.000010] sched_clock: 32 bits at 250MHz, resolution 4ns, wraps every
8589934590ns
[ 0.008195] Calibrating delay loop... 332.54 BogoMIPS (lpj=665088)
[ 0.042319] pid_max: default: 32768 minimum: 301
[ 0.047315] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes)
[ 0.053794] Mountpoint-cache hash table entries: 1024 (order: 0, 4096
bytes)
[ 0.066680] clocksource jiffies: mask: 0xffffffff max_cycles:
0xffffffff, max_idle_ns: 7645041785100000 ns
[ 0.076396] pinctrl core: initialized pinctrl subsystem
[ 0.082215] NET: Registered protocol family 16
[ 0.091078] pinctrl-xway 1e100b10.pinmux: Init done
[ 0.096596] dma-xway 1e104100.dma: Init done - hw rev: 7, ports: 7,
channels: 28
[ 0.207053] dcdc-xrx200 1f106a00.dcdc: Core Voltage : 1016 mV
[ 0.324900] ath9k,eeprom ath9k_eep: failed to load eeprom address
[ 0.352964] usbcore: registered new interface driver usbfs
[ 0.358451] usbcore: registered new interface driver hub
[ 0.363820] usbcore: registered new device driver usb
[ 0.369152] PCI host bridge to bus 0000:00
[ 0.373139] pci_bus 0000:00: root bus resource [mem
0x1c000000-0x1cffffff]
[ 0.380056] pci_bus 0000:00: root bus resource [io
0x1d800000-0x1d8fffff]
[ 0.386999] pci_bus 0000:00: root bus resource [??? 0x00000000 flags
0x0]
[ 0.393854] pci_bus 0000:00: No busn resource found for root bus, will
use [bus 00-ff]
[ 0.401879] pci 0000:00:00.0: [1bef:0011] type 01 class 0x060000
[ 0.401903] ifx_pcie_rc_class_early_fixup: fixed pcie host bridge to
pci-pci bridge
[ 0.419640] pci 0000:00:00.0: PME# supported from D0 D3hot
[ 0.420157] pci 0000:01:00.0: [168c:abcd] type 00 class 0x020000
[ 0.420227] pci 0000:01:00.0: reg 0x10: [mem 0x00000000-0x0001ffff
64bit]
[ 0.420298] pci 0000:01:00.0: reg 0x30: [mem 0x00000000-0x0000ffff
pref]
[ 0.420389] pci 0000:01:00.0: supports D1
[ 0.420410] pci 0000:01:00.0: PME# supported from D0 D1 D3hot
[ 0.420668] pci_bus 0000:01: busn_res: [bus 01-ff] end is updated to 01
[ 0.420704] pci_bus 0000:00: busn_res: [bus 00-ff] end is updated to 01
[ 0.420763] pci 0000:00:00.0: BAR 8: assigned [mem
0x1c000000-0x1c0fffff]
[ 0.427439] pci 0000:00:00.0: BAR 9: assigned [mem
0x1c100000-0x1c1fffff pref]
[ 0.434708] pci 0000:01:00.0: BAR 0: assigned [mem
0x1c000000-0x1c01ffff 64bit]
[ 0.442107] pci 0000:01:00.0: BAR 6: assigned [mem
0x1c100000-0x1c10ffff pref]
[ 0.449370] pci 0000:00:00.0: PCI bridge to [bus 01]
[ 0.454406] pci 0000:00:00.0: bridge window [mem
0x1c000000-0x1c0fffff]
[ 0.461264] pci 0000:00:00.0: bridge window [mem
0x1c100000-0x1c1fffff pref]
[ 0.468572] ifx_pcie_bios_map_irq port 0 dev 0000:00:00.0 slot 0 pin 1
[ 0.475227] ifx_pcie_bios_map_irq dev 0000:00:00.0 irq 144 assigned
[ 0.481578] ifx_pcie_bios_map_irq port 0 dev 0000:01:00.0 slot 0 pin 1
[ 0.488245] ifx_pcie_bios_map_irq dev 0000:01:00.0 irq 144 assigned
[ 0.495537] Switched to clocksource MIPS
[ 0.501117] NET: Registered protocol family 2
[ 0.506521] TCP established hash table entries: 1024 (order: 0, 4096
bytes)
[ 0.513408] TCP bind hash table entries: 1024 (order: 0, 4096 bytes)
[ 0.519785] TCP: Hash tables configured (established 1024 bind 1024)
[ 0.526350] UDP hash table entries: 256 (order: 0, 4096 bytes)
[ 0.532141] UDP-Lite hash table entries: 256 (order: 0, 4096 bytes)
[ 0.538831] NET: Registered protocol family 1
[ 0.543207] PCI: CLS 0 bytes, default 32
[ 0.543624] gptu: totally 6 16-bit timers/counters
[ 0.548421] gptu: misc_register on minor 63
[ 0.552555] gptu: succeeded to request irq 126
[ 0.557048] gptu: succeeded to request irq 127
[ 0.561581] gptu: succeeded to request irq 128
[ 0.566078] gptu: succeeded to request irq 129
[ 0.570588] gptu: succeeded to request irq 130
[ 0.575103] gptu: succeeded to request irq 131
[ 0.580489] phy-xrx200 gphy-xrx200: requesting
lantiq/vr9_phy11g_a2x.bin
[ 0.587984] phy-xrx200 gphy-xrx200: booting GPHY0 firmware at 3A00000
[ 0.594302] phy-xrx200 gphy-xrx200: booting GPHY1 firmware at 3A00000
[ 0.702104] futex hash table entries: 256 (order: -1, 3072 bytes)
[ 0.717174] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[ 0.722913] jffs2: version 2.2 (NAND) (SUMMARY) (LZMA) (RTIME)
(CMODE_PRIORITY) (c) 2001-2006 Red Hat, Inc.
[ 0.734477] io scheduler noop registered
[ 0.738320] io scheduler deadline registered (default)
[ 0.744212] 1e100c00.serial: ttyLTQ0 at MMIO 0x1e100c00 (irq = 112,
base_baud = 0) is a lantiq,asc
[ 0.753099] console [ttyLTQ0] enabled
[ 0.760431] bootconsole [early0] disabled
[ 0.971555] spi-xway 1e100800.spi: SPI wait ready timed out stat:
a4002003
[ 0.977005] m25p80 spi32766.3: wait failed
[ 1.179545] spi-xway 1e100800.spi: SPI wait ready timed out stat:
a4002003
[ 1.185083] m25p80 spi32766.3: s25fl064k (8192 Kbytes)
[ 1.190168] 4 ofpart partitions found on MTD device spi32766.3
[ 1.195957] Creating 4 MTD partitions on "spi32766.3":
[ 1.201097] 0x000000000000-0x000000020000 : "u-boot"
[ 1.207166] 0x000000020000-0x0000007c0000 : "firmware"
[ 1.213876] 0x0000001bc99c-0x0000007c0000 : "rootfs"
[ 1.218512] mtd: device 2 (rootfs) set to be root filesystem
[ 1.224032] 1 squashfs-split partitions found on MTD device rootfs
[ 1.229284] 0x0000005c0000-0x0000007c0000 : "rootfs_data"
[ 1.305930] 0x0000007c0000-0x0000007d0000 : "config"
[ 1.310575] 0x0000007d0000-0x000000800000 : "boardconfig"
[ 1.316076] Lantiq SoC SPI controller rev 8 (TXFS 8, RXFS 8, DMA 1)
[ 1.423669] libphy: lantiq,xrx200-mdio: probed
[ 1.496269] eth0: attached PHY [Lantiq XWAY PEF7071] (phy_addr=0:00,
irq=-1)
[ 1.564243] eth0: attached PHY [Lantiq XWAY PEF7071] (phy_addr=0:05,
irq=-1)
[ 1.632227] eth0: attached PHY [Lantiq XWAY VR9 GPHY 11G v1.4]
(phy_addr=0:11, irq=-1)
[ 1.700226] eth0: attached PHY [Lantiq XWAY VR9 GPHY 11G v1.4]
(phy_addr=0:13, irq=-1)
[ 1.708094] wdt 1f8803f0.watchdog: Init done
[ 1.712950] NET: Registered protocol family 10
[ 1.719420] NET: Registered protocol family 17
[ 1.722559] bridge: automatic filtering via arp/ip/ip6tables has been
deprecated. Update your scripts to load br_netfilter if you need this.
[ 1.735089] 8021q: 802.1Q VLAN Support v1.8
[ 1.741573] ath9k,eeprom ath9k_eep: using led pin 0.
[ 1.745132] ath9k,eeprom ath9k_eep: loaded ath9k eeprom
[ 1.754607] UBIFS error (pid: 1): cannot open "ubi0:rootfs", error -19
[ 1.765409] VFS: Mounted root (squashfs filesystem) readonly on device
31:2.
[ 1.771918] Freeing unused kernel memory: 188K (804d1000 - 80500000)
[ 1.800124] random: nonblocking pool is initialized
[ 3.061729] init: Console is alive
[ 3.064023] init: - watchdog -
[ 4.618784] dwc2 1e101000.ifxhcd: requested GPIO 489
[ 5.479731] dwc2 1e101000.ifxhcd: DWC OTG Controller
[ 5.483302] dwc2 1e101000.ifxhcd: new USB bus registered, assigned bus
number 1
[ 5.490639] dwc2 1e101000.ifxhcd: irq 62, io mem 0x00000000
[ 5.496166] dwc2 1e101000.ifxhcd: Hardware does not support descriptor
DMA mode -
[ 5.503608] dwc2 1e101000.ifxhcd: falling back to buffer DMA mode.
[ 5.510937] hub 1-0:1.0: USB hub found
[ 5.514029] hub 1-0:1.0: 1 port detected
[ 5.627791] eth0: port 5 got link
[ 6.375738] dwc2 1e106000.ifxhcd: DWC OTG Controller
[ 6.379310] dwc2 1e106000.ifxhcd: new USB bus registered, assigned bus
number 2
[ 6.386647] dwc2 1e106000.ifxhcd: irq 91, io mem 0x00000000
[ 6.392172] dwc2 1e106000.ifxhcd: Hardware does not support descriptor
DMA mode -
[ 6.399616] dwc2 1e106000.ifxhcd: falling back to buffer DMA mode.
[ 6.406969] hub 2-0:1.0: USB hub found
[ 6.410019] hub 2-0:1.0: 1 port detected
[ 7.137808] init: - preinit -
[ 10.935214] jffs2: notice: (298) jffs2_build_xattr_subsystem: complete
building xattr subsystem, 0 of xdatum (0 unchecked, 0 orphan) and 0 of
xref (0 dead, 0 orphan) found.
[ 11.147559] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 11.153018] m25p80 spi32766.3: wait failed
[ 11.355554] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 11.559559] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 11.565012] m25p80 spi32766.3: wait failed
[ 11.767555] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 11.774087] mount_root: switching to jffs2 overlay
[ 11.979559] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 11.985016] m25p80 spi32766.3: wait failed
[ 12.187555] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 12.399559] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 12.405021] m25p80 spi32766.3: wait failed
[ 12.607557] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 12.643260] procd: - early -
[ 12.644919] procd: - watchdog -
[ 12.885938] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 12.891434] m25p80 spi32766.3: wait failed
[ 13.115620] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 13.482146] procd: - ubus -
[ 13.607559] spi-xway 1e100800.spi: SPI wait ready timed out stat:
44002003
[ 13.613025] m25p80 spi32766.3: wait failed
[ 13.627585] eth0: port 5 lost link
[ 13.815553] spi-xway 1e100800.spi: SPI wait ready timed out stat:
44002003
[ 14.019556] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 14.025017] m25p80 spi32766.3: wait failed
[ 14.227551] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 14.431554] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 14.437010] m25p80 spi32766.3: wait failed
[ 14.639559] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 14.656618] procd: - init -
[ 14.851559] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 14.857017] m25p80 spi32766.3: wait failed
[ 15.059551] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 15.263580] spi-xway 1e100800.spi: SPI wait ready timed out stat:
b4002003
[ 15.269048] m25p80 spi32766.3: wait failed
[ 15.471552] spi-xway 1e100800.spi: SPI wait ready timed out stat:
b4002003
[ 15.675555] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 15.681013] m25p80 spi32766.3: wait failed
[ 15.883551] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 16.087557] spi-xway 1e100800.spi: SPI wait ready timed out stat:
b4002003
[ 16.093018] m25p80 spi32766.3: wait failed
[ 16.295551] spi-xway 1e100800.spi: SPI wait ready timed out stat:
b4002003
[ 16.499555] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 16.505011] m25p80 spi32766.3: wait failed
[ 16.707551] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 16.911555] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 16.917005] m25p80 spi32766.3: wait failed
[ 17.119550] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 17.323557] spi-xway 1e100800.spi: SPI wait ready timed out stat:
b4002003
[ 17.329009] m25p80 spi32766.3: wait failed
[ 17.531551] spi-xway 1e100800.spi: SPI wait ready timed out stat:
b4002003
[ 17.735556] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 17.741015] m25p80 spi32766.3: wait failed
[ 17.943554] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 18.147556] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 18.153008] m25p80 spi32766.3: wait failed
[ 18.355551] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 18.559555] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 18.565021] m25p80 spi32766.3: wait failed
[ 18.767589] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 18.971572] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 18.977027] m25p80 spi32766.3: wait failed
[ 19.179551] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 19.391559] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 19.397022] m25p80 spi32766.3: wait failed
[ 19.599552] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 19.803556] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 19.809015] m25p80 spi32766.3: wait failed
[ 20.011554] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 20.215556] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 20.221010] m25p80 spi32766.3: wait failed
[ 20.423551] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 20.627580] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 20.633043] m25p80 spi32766.3: wait failed
[ 20.835551] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 21.039555] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 21.045006] m25p80 spi32766.3: wait failed
[ 21.247551] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 21.487559] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 21.493015] m25p80 spi32766.3: wait failed
[ 21.695552] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 21.899557] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 21.905016] m25p80 spi32766.3: wait failed
[ 22.107553] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 22.311555] spi-xway 1e100800.spi: SPI wait ready timed out stat:
b4002003
[ 22.317015] m25p80 spi32766.3: wait failed
[ 22.519551] spi-xway 1e100800.spi: SPI wait ready timed out stat:
b4002003
[ 22.731559] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 22.737016] m25p80 spi32766.3: wait failed
[ 22.939551] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 23.199559] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 23.205024] m25p80 spi32766.3: wait failed
[ 23.407551] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 23.611557] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 23.617014] m25p80 spi32766.3: wait failed
[ 23.819552] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 24.023565] spi-xway 1e100800.spi: SPI wait ready timed out stat:
44002003
[ 24.029020] m25p80 spi32766.3: wait failed
[ 24.231551] spi-xway 1e100800.spi: SPI wait ready timed out stat:
44002003
[ 24.435556] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 24.441020] m25p80 spi32766.3: wait failed
[ 24.643551] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 24.847558] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 24.853017] m25p80 spi32766.3: wait failed
[ 25.055551] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 25.318994] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 25.324489] m25p80 spi32766.3: wait failed
[ 25.534717] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 25.795559] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 25.801018] m25p80 spi32766.3: wait failed
[ 26.003553] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 26.235559] spi-xway 1e100800.spi: SPI wait ready timed out stat:
44002003
[ 26.241028] m25p80 spi32766.3: wait failed
[ 26.443551] spi-xway 1e100800.spi: SPI wait ready timed out stat:
44002003
[ 26.647556] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 26.653013] m25p80 spi32766.3: wait failed
[ 26.855551] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 27.059556] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 27.065007] m25p80 spi32766.3: wait failed
[ 27.267576] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 27.486881] IFXOS, Version 1.5.19 (c) Copyright 2009, Lantiq
Deutschland GmbH
[ 27.496923] NET: Registered protocol family 8
[ 27.499883] NET: Registered protocol family 20
[ 27.509107] tun: Universal TUN/TAP device driver, 1.6
[ 27.512764] tun: (C) 1999-2004 Max Krasnyansky <[email protected]>
[ 27.537698] PPP generic driver version 2.4.2
[ 27.557381] ip6_tables: (C) 2000-2006 Netfilter Core Team
[ 27.587653] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 27.593123] m25p80 spi32766.3: wait failed
[ 27.613042] Lantiq (VRX) DSL CPE MEI driver, version 1.4.8.5, (c) 2013
Lantiq Deutschland GmbH
[ 27.613042]
[ 27.613042] Lantiq CPE API Driver version: DSL CPE API V4.16.6.3
[ 27.667633]
[ 27.667633] Predefined debug level: 3
[ 27.709734] u32 classifier
[ 27.710986] input device check on
[ 27.714679] Actions configured
[ 27.749741] Mirror/redirect action on
[ 27.764487] nf_conntrack version 0.5.0 (933 buckets, 3732 max)
[ 27.775023] Loading modules backported from Linux version
master-2015-12-03-0-g1677f62
[ 27.781552] Backport generated by backports.git
backports-20151120-0-g906a6b3
[ 27.792409] ip_tables: (C) 2000-2006 Netfilter Core Team
[ 27.796706] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 27.811703] Infineon Technologies DEU driver version 2.0.0
[ 27.817563] IFX DEU DES initialized (multiblock).
[ 27.821796] IFX DEU AES initialized (multiblock).
[ 27.825949] IFX DEU ARC4 initialized (multiblock).
[ 27.830579] IFX DEU SHA1 initialized.
[ 27.834186] IFX DEU MD5 initialized.
[ 27.837777] IFX DEU SHA1_HMAC initialized.
[ 27.841896] IFX DEU MD5_HMAC initialized.
[ 27.868228] NET: Registered protocol family 24
[ 27.922929] xt_time: kernel timezone is -0000
[ 28.071583] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 28.077057] m25p80 spi32766.3: wait failed
[ 28.279552] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 28.316751] cfg80211: World regulatory domain updated:
[ 28.320505] cfg80211: DFS Master region: unset
[ 28.324814] cfg80211: (start_freq - end_freq @ bandwidth),
(max_antenna_gain, max_eirp), (dfs_cac_time)
[ 28.334576] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A,
2000 mBm), (N/A)
[ 28.342580] cfg80211: (2457000 KHz - 2482000 KHz @ 40000 KHz), (N/A,
2000 mBm), (N/A)
[ 28.350587] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A,
2000 mBm), (N/A)
[ 28.358600] cfg80211: (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000
KHz AUTO), (N/A, 2000 mBm), (N/A)
[ 28.368086] cfg80211: (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000
KHz AUTO), (N/A, 2000 mBm), (0 s)
[ 28.377575] cfg80211: (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A,
2000 mBm), (0 s)
[ 28.385666] cfg80211: (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A,
2000 mBm), (N/A)
[ 28.393672] cfg80211: (57240000 KHz - 63720000 KHz @ 2160000 KHz),
(N/A, 0 mBm), (N/A)
[ 28.627586] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 28.633059] m25p80 spi32766.3: wait failed
[ 28.835551] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 28.937986] PCI: Enabling device 0000:00:00.0 (0000 -> 0002)
[ 28.942339] PCI: Enabling device 0000:01:00.0 (0000 -> 0002)
[ 28.952901] ath: EEPROM regdomain: 0x0
[ 28.952925] ath: EEPROM indicates default country code should be used
[ 28.952936] ath: doing EEPROM country->regdmn map search
[ 28.952959] ath: country maps to regdmn code: 0x3a
[ 28.952971] ath: Country alpha2 being used: US
[ 28.952983] ath: Regpair used: 0x3a
[ 28.962568] ieee80211 phy0: Selected rate control algorithm
'minstrel_ht'
[ 28.965982] ieee80211 phy0: Atheros AR9300 Rev:3 mem=0xbc000000,
irq=144
[ 28.974274] cfg80211: Regulatory domain changed to country: US
[ 28.978722] cfg80211: DFS Master region: FCC
[ 28.982854] cfg80211: (start_freq - end_freq @ bandwidth),
(max_antenna_gain, max_eirp), (dfs_cac_time)
[ 28.992615] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A,
3000 mBm), (N/A)
[ 29.000623] cfg80211: (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000
KHz AUTO), (N/A, 2300 mBm), (N/A)
[ 29.010111] cfg80211: (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000
KHz AUTO), (N/A, 2300 mBm), (0 s)
[ 29.019603] cfg80211: (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A,
2300 mBm), (0 s)
[ 29.027690] cfg80211: (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A,
3000 mBm), (N/A)
[ 29.035697] cfg80211: (57240000 KHz - 63720000 KHz @ 2160000 KHz),
(N/A, 4000 mBm), (N/A)
[ 29.087639] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 29.093107] m25p80 spi32766.3: wait failed
[ 29.295558] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 29.499555] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 29.505010] m25p80 spi32766.3: wait failed
[ 29.707552] spi-xway 1e100800.spi: SPI wait ready timed out stat:
c4002003
[ 31.135558] spi-xway 1e100800.spi: SPI wait ready timed out stat:
b4002003
[ 31.141015] m25p80 spi32766.3: wait failed
[ 31.343550] spi-xway 1e100800.spi: SPI wait ready timed out stat:
b4002003
[ 36.024533] PTM 1.0.27 PTM (E1) firmware version 0.30
[ 36.028457] ifxmips_ptm: PTM init succeed
[ 41.469686] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[ 41.499113] device eth0.1 entered promiscuous mode
[ 41.502520] device eth0 entered promiscuous mode
[ 41.532964] IPv6: ADDRCONF(NETDEV_UP): br-lan: link is not ready
[ 41.607702] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 41.646804] device ptm0 entered promiscuous mode
[ 41.655724] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 41.803458] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 41.907672] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 42.003791] eth0: port 5 got link
[ 42.005961] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[ 42.047687] br-lan: port 1(eth0.1) entered forwarding state
[ 42.051925] br-lan: port 1(eth0.1) entered forwarding state
[ 42.103638] IPv6: ADDRCONF(NETDEV_CHANGE): br-lan: link becomes ready
[ 42.227694] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 42.463746] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 42.799839] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 42.814645] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 43.004368] br-lan: port 1(eth0.1) entered disabled state
[ 43.175659] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 43.463842] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 43.478658] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 43.576624] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 43.807690] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 44.004515] br-lan: port 1(eth0.1) entered forwarding state
[ 44.008744] br-lan: port 1(eth0.1) entered forwarding state
[ 44.159716] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 44.439725] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 46.011605] br-lan: port 1(eth0.1) entered forwarding state
[ 48.692223] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 53.723729] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 58.902353] device ptm0 left promiscuous mode
[ 58.919727] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 58.938000] device ptm0 entered promiscuous mode
[ 58.947733] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 59.135739] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 59.225649] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 59.383684] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 59.563649] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 59.923667] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 60.135800] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 60.150617] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 60.179640] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 60.207652] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 60.383793] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 60.398613] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 60.891663] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 60.906483] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 64.243640] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 69.259728] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 74.412827] device ptm0 left promiscuous mode
[ 74.428735] device ptm0 entered promiscuous mode
[ 74.432104] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 74.455734] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 74.575772] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 74.740484] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 74.827652] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 74.879651] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 75.111689] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 75.575808] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 75.590638] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 76.011658] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 76.111801] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 76.126620] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 76.519664] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 76.791642] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 76.939708] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 79.759653] /home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
[ 84.706986] enter showtime
[ 84.712034] enter showtime
[ 89.900296] device ptm0 left promiscuous mode
[ 89.916678] device ptm0 entered promiscuous mode
[ 105.308385] device ptm0 left promiscuous mode
[ 105.325049] device ptm0 entered promiscuous mode
[ 110.947277] pppoe-wan: renamed from ppp0
}}}
and complete system log
{{{
Mon Dec 7 17:26:28 2015 daemon.info dnsmasq[1376]: using local addresses
only for domain lan
Mon Dec 7 17:26:28 2015 daemon.warn dnsmasq[1376]: no servers found in
/tmp/resolv.conf.auto, will retry
Mon Dec 7 17:26:28 2015 daemon.info dnsmasq[1376]: read /etc/hosts - 4
addresses
Mon Dec 7 17:26:28 2015 daemon.info dnsmasq[1376]: read /tmp/hosts/dhcp -
1 addresses
Mon Dec 7 17:26:28 2015 daemon.info dnsmasq-dhcp[1376]: read /etc/ethers
- 0 addresses
Mon Dec 7 17:26:29 2015 daemon.info dnsmasq-dhcp[1376]: DHCPREQUEST(br-
lan) 192.168.1.139 88:ae:1d:57:7e:55
Mon Dec 7 17:26:29 2015 daemon.info dnsmasq-dhcp[1376]: DHCPACK(br-lan)
192.168.1.139 88:ae:1d:57:7e:55 dan10alm
Mon Dec 7 17:26:29 2015 daemon.warn odhcpd[812]: DHCPV6 SOLICIT IA_NA
from 000100011d63f4e488ae1d577e55 on br-lan: ok fdd2:2baa:11c0::c2c/128
Mon Dec 7 17:26:30 2015 daemon.info dnsmasq[1376]: read /etc/hosts - 4
addresses
Mon Dec 7 17:26:30 2015 daemon.info dnsmasq[1376]: read /tmp/hosts/odhcpd
- 0 addresses
Mon Dec 7 17:26:30 2015 daemon.info dnsmasq[1376]: read /tmp/hosts/dhcp -
1 addresses
Mon Dec 7 17:26:30 2015 daemon.info dnsmasq-dhcp[1376]: read /etc/ethers
- 0 addresses
Mon Dec 7 17:26:30 2015 daemon.warn odhcpd[812]: DHCPV6 REQUEST IA_NA
from 000100011d63f4e488ae1d577e55 on br-lan: ok fdd2:2baa:11c0::c2c/128
Mon Dec 7 17:26:31 2015 kern.err kernel: [ 53.723729]
/home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
Mon Dec 7 17:26:34 2015 authpriv.notice dropbear[1372]: Password auth
succeeded for 'root' from 192.168.1.139:13811
Mon Dec 7 17:26:36 2015 daemon.warn pppd[1104]: Timeout waiting for PADO
packets
Mon Dec 7 17:26:36 2015 daemon.err pppd[1104]: Unable to complete PPPoE
Discovery
Mon Dec 7 17:26:36 2015 daemon.info pppd[1104]: Exit.
Mon Dec 7 17:26:36 2015 daemon.notice netifd: Interface 'wan' is now down
Mon Dec 7 17:26:36 2015 kern.info kernel: [ 58.902353] device ptm0 left
promiscuous mode
Mon Dec 7 17:26:36 2015 daemon.notice netifd: Interface 'wan' is disabled
Mon Dec 7 17:26:36 2015 kern.err kernel: [ 58.919727]
/home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
Mon Dec 7 17:26:36 2015 daemon.notice netifd: Interface 'wan' is enabled
Mon Dec 7 17:26:36 2015 daemon.notice netifd: Interface 'wan' is setting
up now
Mon Dec 7 17:26:36 2015 kern.info kernel: [ 58.938000] device ptm0
entered promiscuous mode
Mon Dec 7 17:26:36 2015 kern.err kernel: [ 58.947733]
/home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
Mon Dec 7 17:26:36 2015 kern.err kernel: [ 59.135739]
/home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
Mon Dec 7 17:26:36 2015 daemon.info pppd[1611]: Plugin rp-pppoe.so
loaded.
Mon Dec 7 17:26:36 2015 daemon.info pppd[1611]: RP-PPPoE plugin version
3.8p compiled against pppd 2.4.7
Mon Dec 7 17:26:36 2015 daemon.notice pppd[1611]: pppd 2.4.7 started by
root, uid 0
Mon Dec 7 17:26:36 2015 kern.err kernel: [ 59.225649]
/home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
Mon Dec 7 17:26:37 2015 kern.err kernel: [ 59.383684]
/home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
Mon Dec 7 17:26:37 2015 kern.err kernel: [ 59.563649]
/home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
Mon Dec 7 17:26:37 2015 kern.err kernel: [ 59.923667]
/home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
Mon Dec 7 17:26:37 2015 kern.err kernel: [ 60.135800]
/home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
Mon Dec 7 17:26:37 2015 kern.err kernel: [ 60.150617]
/home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
Mon Dec 7 17:26:37 2015 kern.err kernel: [ 60.179640]
/home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
Mon Dec 7 17:26:37 2015 kern.err kernel: [ 60.207652]
/home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
Mon Dec 7 17:26:38 2015 kern.err kernel: [ 60.383793]
/home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
Mon Dec 7 17:26:38 2015 kern.err kernel: [ 60.398613]
/home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
Mon Dec 7 17:26:38 2015 kern.err kernel: [ 60.891663]
/home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
Mon Dec 7 17:26:38 2015 kern.err kernel: [ 60.906483]
/home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
Mon Dec 7 17:26:41 2015 kern.err kernel: [ 64.243640]
/home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
Mon Dec 7 17:26:46 2015 kern.err kernel: [ 69.259728]
/home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
Mon Dec 7 17:26:51 2015 daemon.warn pppd[1611]: Timeout waiting for PADO
packets
Mon Dec 7 17:26:51 2015 daemon.err pppd[1611]: Unable to complete PPPoE
Discovery
Mon Dec 7 17:26:51 2015 daemon.info pppd[1611]: Exit.
Mon Dec 7 17:26:52 2015 daemon.notice netifd: Interface 'wan' is now down
Mon Dec 7 17:26:52 2015 kern.info kernel: [ 74.412827] device ptm0 left
promiscuous mode
Mon Dec 7 17:26:52 2015 daemon.notice netifd: Interface 'wan' is disabled
Mon Dec 7 17:26:52 2015 kern.info kernel: [ 74.428735] device ptm0
entered promiscuous mode
Mon Dec 7 17:26:52 2015 kern.err kernel: [ 74.432104]
/home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
Mon Dec 7 17:26:52 2015 daemon.notice netifd: Interface 'wan' is enabled
Mon Dec 7 17:26:52 2015 daemon.notice netifd: Interface 'wan' is setting
up now
Mon Dec 7 17:26:52 2015 kern.err kernel: [ 74.455734]
/home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
Mon Dec 7 17:26:52 2015 kern.err kernel: [ 74.575772]
/home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
Mon Dec 7 17:26:52 2015 daemon.info pppd[2201]: Plugin rp-pppoe.so
loaded.
Mon Dec 7 17:26:52 2015 daemon.info pppd[2201]: RP-PPPoE plugin version
3.8p compiled against pppd 2.4.7
Mon Dec 7 17:26:52 2015 daemon.notice pppd[2201]: pppd 2.4.7 started by
root, uid 0
Mon Dec 7 17:26:52 2015 kern.err kernel: [ 74.740484]
/home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
Mon Dec 7 17:26:52 2015 kern.err kernel: [ 74.827652]
/home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
Mon Dec 7 17:26:52 2015 kern.err kernel: [ 74.879651]
/home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
Mon Dec 7 17:26:52 2015 kern.err kernel: [ 75.111689]
/home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
Mon Dec 7 17:26:53 2015 kern.err kernel: [ 75.575808]
/home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
Mon Dec 7 17:26:53 2015 kern.err kernel: [ 75.590638]
/home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
Mon Dec 7 17:26:53 2015 kern.err kernel: [ 76.011658]
/home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
Mon Dec 7 17:26:53 2015 kern.err kernel: [ 76.111801]
/home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
Mon Dec 7 17:26:53 2015 kern.err kernel: [ 76.126620]
/home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
Mon Dec 7 17:26:54 2015 kern.err kernel: [ 76.519664]
/home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
Mon Dec 7 17:26:54 2015 kern.err kernel: [ 76.791642]
/home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
Mon Dec 7 17:26:54 2015 kern.err kernel: [ 76.939708]
/home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
Mon Dec 7 17:26:57 2015 kern.err kernel: [ 79.759653]
/home/daniele/dev/openwrt/openwrt/build_dir/target-
mips_34kc+dsp_musl-1.1.11/linux-lantiq_xrx200/ltq-ptm-
vr9/ifxmips_ptm_vdsl.c:281:ptm_hard_start_xmit: not in showtime
Mon Dec 7 17:27:02 2015 kern.warn kernel: [ 84.706986] enter showtime
Mon Dec 7 17:27:02 2015 kern.warn kernel: [ 84.712034] enter showtime
Mon Dec 7 17:27:07 2015 daemon.warn pppd[2201]: Timeout waiting for PADO
packets
Mon Dec 7 17:27:07 2015 daemon.err pppd[2201]: Unable to complete PPPoE
Discovery
Mon Dec 7 17:27:07 2015 daemon.info pppd[2201]: Exit.
Mon Dec 7 17:27:07 2015 daemon.notice netifd: Interface 'wan' is now down
Mon Dec 7 17:27:07 2015 kern.info kernel: [ 89.900296] device ptm0 left
promiscuous mode
Mon Dec 7 17:27:07 2015 daemon.notice netifd: Interface 'wan' is disabled
Mon Dec 7 17:27:07 2015 kern.info kernel: [ 89.916678] device ptm0
entered promiscuous mode
Mon Dec 7 17:27:07 2015 daemon.notice netifd: Interface 'wan' is enabled
Mon Dec 7 17:27:07 2015 daemon.notice netifd: Interface 'wan' is setting
up now
Mon Dec 7 17:27:07 2015 daemon.info pppd[3105]: Plugin rp-pppoe.so
loaded.
Mon Dec 7 17:27:07 2015 daemon.info pppd[3105]: RP-PPPoE plugin version
3.8p compiled against pppd 2.4.7
Mon Dec 7 17:27:07 2015 daemon.notice pppd[3105]: pppd 2.4.7 started by
root, uid 0
Mon Dec 7 17:27:22 2015 daemon.warn pppd[3105]: Timeout waiting for PADO
packets
Mon Dec 7 17:27:22 2015 daemon.err pppd[3105]: Unable to complete PPPoE
Discovery
Mon Dec 7 17:27:22 2015 daemon.info pppd[3105]: Exit.
Mon Dec 7 17:27:22 2015 daemon.notice netifd: Interface 'wan' is now down
Mon Dec 7 17:27:22 2015 kern.info kernel: [ 105.308385] device ptm0 left
promiscuous mode
Mon Dec 7 17:27:22 2015 daemon.notice netifd: Interface 'wan' is disabled
Mon Dec 7 17:27:22 2015 kern.info kernel: [ 105.325049] device ptm0
entered promiscuous mode
Mon Dec 7 17:27:22 2015 daemon.notice netifd: Interface 'wan' is enabled
Mon Dec 7 17:27:22 2015 daemon.notice netifd: Interface 'wan' is setting
up now
Mon Dec 7 17:27:23 2015 daemon.info pppd[4017]: Plugin rp-pppoe.so
loaded.
Mon Dec 7 17:27:23 2015 daemon.info pppd[4017]: RP-PPPoE plugin version
3.8p compiled against pppd 2.4.7
Mon Dec 7 17:27:23 2015 daemon.notice pppd[4017]: pppd 2.4.7 started by
root, uid 0
Mon Dec 7 17:27:28 2015 daemon.info pppd[4017]: PPP session is 1537
Mon Dec 7 17:27:28 2015 daemon.warn pppd[4017]: Connected to
88:a2:5e:17:be:be via interface ptm0.835
Mon Dec 7 17:27:28 2015 kern.info kernel: [ 110.947277] pppoe-wan:
renamed from ppp0
Mon Dec 7 17:27:28 2015 daemon.info pppd[4017]: Using interface pppoe-wan
Mon Dec 7 17:27:28 2015 daemon.notice pppd[4017]: Connect: pppoe-wan <-->
ptm0.835
Mon Dec 7 17:27:28 2015 daemon.notice pppd[4017]: PAP authentication
succeeded
Mon Dec 7 17:27:28 2015 daemon.notice pppd[4017]: peer from calling
number 88:A2:5E:17:BE:BE authorized
Mon Dec 7 17:27:28 2015 daemon.notice netifd: Network device 'pppoe-wan'
link is up
Mon Dec 7 17:27:28 2015 daemon.notice netifd: Interface 'wan6' has link
connectivity
Mon Dec 7 17:27:28 2015 daemon.notice pppd[4017]: local IP address
95.238.236.181
Mon Dec 7 17:27:28 2015 daemon.notice pppd[4017]: remote IP address
192.168.100.1
Mon Dec 7 17:27:28 2015 daemon.notice pppd[4017]: primary DNS address
85.37.17.17
Mon Dec 7 17:27:28 2015 daemon.notice pppd[4017]: secondary DNS address
85.38.28.72
Mon Dec 7 17:27:28 2015 daemon.notice pppd[4017]: local LL address
fe80::2836:e976:182d:2f96
Mon Dec 7 17:27:28 2015 daemon.notice pppd[4017]: remote LL address
fe80::02a0:a50f:fc86:8004
Mon Dec 7 17:27:28 2015 daemon.info pppd[4017]: IPV6CP terminated by peer
Mon Dec 7 17:27:29 2015 daemon.notice netifd: Interface 'wan6' is enabled
Mon Dec 7 17:27:29 2015 daemon.notice netifd: Interface 'wan6' is setting
up now
Mon Dec 7 17:27:29 2015 daemon.notice netifd: Interface 'wan' is now up
Mon Dec 7 17:27:29 2015 daemon.info dnsmasq[1376]: reading
/tmp/resolv.conf.auto
Mon Dec 7 17:27:29 2015 daemon.info dnsmasq[1376]: using local addresses
only for domain lan
Mon Dec 7 17:27:29 2015 daemon.info dnsmasq[1376]: using nameserver
85.37.17.17#53
Mon Dec 7 17:27:29 2015 daemon.info dnsmasq[1376]: using nameserver
85.38.28.72#53
Mon Dec 7 17:27:29 2015 daemon.notice netifd: Network alias 'pppoe-wan'
link is up
Mon Dec 7 17:27:29 2015 daemon.notice netifd: Interface 'wan_6' is
enabled
Mon Dec 7 17:27:29 2015 daemon.notice netifd: Interface 'wan_6' has link
connectivity
Mon Dec 7 17:27:29 2015 daemon.notice netifd: Interface 'wan_6' is
setting up now
Mon Dec 7 17:27:29 2015 daemon.info dnsmasq[1376]: reading
/tmp/resolv.conf.auto
Mon Dec 7 17:27:29 2015 daemon.info dnsmasq[1376]: using local addresses
only for domain lan
Mon Dec 7 17:27:29 2015 daemon.info dnsmasq[1376]: using nameserver
85.37.17.17#53
Mon Dec 7 17:27:29 2015 daemon.info dnsmasq[1376]: using nameserver
85.38.28.72#53
Mon Dec 7 17:27:29 2015 daemon.info dnsmasq[1376]: using nameserver
85.37.17.17#53
Mon Dec 7 17:27:29 2015 daemon.info dnsmasq[1376]: using nameserver
85.38.28.72#53
Mon Dec 7 17:27:29 2015 daemon.notice netifd: Interface 'wan' has lost
the connection
Mon Dec 7 17:27:29 2015 daemon.warn dnsmasq[1376]: no servers found in
/tmp/resolv.conf.auto, will retry
Mon Dec 7 17:27:29 2015 daemon.notice netifd: Interface 'wan_6' is now
down
Mon Dec 7 17:27:29 2015 daemon.notice netifd: Interface 'wan_6' is
disabled
Mon Dec 7 17:27:29 2015 daemon.notice netifd: Interface 'wan_6' has link
connectivity loss
Mon Dec 7 17:27:30 2015 user.notice firewall: Reloading firewall due to
ifup of wan (pppoe-wan)
Mon Dec 7 17:27:33 2015 user.notice ddns-scripts[4579]: myddns_ipv4: PID
'4579' started at 2015-12-07 17:27
Mon Dec 7 17:27:33 2015 user.warn ddns-scripts[4579]: myddns_ipv4:
Service section disabled! - TERMINATE
Mon Dec 7 17:27:34 2015 user.warn ddns-scripts[4579]: myddns_ipv4: PID
'4579' exit WITH ERROR '1' at 2015-12-07 17:27
Mon Dec 7 17:27:35 2015 daemon.err uhttpd[1243]: sh: write error: Broken
pipe
Mon Dec 7 17:27:35 2015 daemon.err uhttpd[1243]: sh: write error: Broken
pipe
Mon Dec 7 17:27:35 2015 daemon.err uhttpd[1243]: sh: write error: Broken
pipe
Mon Dec 7 17:27:35 2015 daemon.err uhttpd[1243]: sh: write error: Broken
pipe
Mon Dec 7 17:27:35 2015 daemon.err uhttpd[1243]: sh: write error: Broken
pipe
Mon Dec 7 17:27:35 2015 daemon.err uhttpd[1243]: sh: write error: Broken
pipe
Mon Dec 7 17:27:35 2015 daemon.err uhttpd[1243]: sh: write error: Broken
pipe
Mon Dec 7 17:27:35 2015 daemon.err uhttpd[1243]: sh: write error: Broken
pipe
Mon Dec 7 17:27:35 2015 daemon.err uhttpd[1243]: sh: write error: Broken
pipe
Mon Dec 7 17:27:35 2015 daemon.err uhttpd[1243]: sh: write error: Broken
pipe
Mon Dec 7 17:27:35 2015 daemon.err uhttpd[1243]: sh: write error: Broken
pipe
Mon Dec 7 17:27:35 2015 daemon.err uhttpd[1243]: sh: write error: Broken
pipe
Mon Dec 7 17:27:35 2015 daemon.err uhttpd[1243]: sh: write error: Broken
pipe
Mon Dec 7 17:27:35 2015 daemon.err uhttpd[1243]: sh: write error: Broken
pipe
Mon Dec 7 17:27:35 2015 daemon.err uhttpd[1243]: sh: write error: Broken
pipe
}}}
Let me know it there is something else I can do in order to investigate
deeper the problem
Thanks for the support
D.
--
Ticket URL: <https://dev.openwrt.org/ticket/21319#comment:7>
OpenWrt <http://openwrt.org>
Opensource Wireless Router Technology
_______________________________________________
openwrt-tickets mailing list
[email protected]
https://lists.openwrt.org/cgi-bin/mailman/listinfo/openwrt-tickets
