#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@…):

 Tried now with a fresh and clean build from trunk. Unfortunately the
 situation is the same

 {{{
 [    0.000000] Linux version 4.1.13 ([email protected]) (gcc
 version 5.2.0 (OpenWrt GCC 5.2.0 r47811) ) #1 Tue Dec 8 18:40:30 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=00068a20
 [    0.000000] Readback ErrCtl register=00068a20
 [    0.000000] Memory: 59556K/65536K available (3771K kernel code, 149K
 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.008194] Calibrating delay loop... 332.54 BogoMIPS (lpj=665088)
 [    0.042319] pid_max: default: 32768 minimum: 301
 [    0.047314] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes)
 [    0.053785] Mountpoint-cache hash table entries: 1024 (order: 0, 4096
 bytes)
 [    0.066669] clocksource jiffies: mask: 0xffffffff max_cycles:
 0xffffffff, max_idle_ns: 7645041785100000 ns
 [    0.076388] pinctrl core: initialized pinctrl subsystem
 [    0.082206] NET: Registered protocol family 16
 [    0.091075] pinctrl-xway 1e100b10.pinmux: Init done
 [    0.096596] dma-xway 1e104100.dma: Init done - hw rev: 7, ports: 7,
 channels: 28
 [    0.207055] dcdc-xrx200 1f106a00.dcdc: Core Voltage : 1016 mV
 [    0.324903] ath9k,eeprom ath9k_eep: failed to load eeprom address
 [    0.352958] usbcore: registered new interface driver usbfs
 [    0.358452] usbcore: registered new interface driver hub
 [    0.363820] usbcore: registered new device driver usb
 [    0.369151] 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.386998] pci_bus 0000:00: root bus resource [??? 0x00000000 flags
 0x0]
 [    0.393855] pci_bus 0000:00: No busn resource found for root bus, will
 use [bus 00-ff]
 [    0.401880] pci 0000:00:00.0: [1bef:0011] type 01 class 0x060000
 [    0.401904] 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.420158] 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.420299] pci 0000:01:00.0: reg 0x30: [mem 0x00000000-0x0000ffff
 pref]
 [    0.420390] pci 0000:01:00.0: supports D1
 [    0.420411] 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.420705] 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.454407] pci 0000:00:00.0:   bridge window [mem
 0x1c000000-0x1c0fffff]
 [    0.461263] pci 0000:00:00.0:   bridge window [mem
 0x1c100000-0x1c1fffff pref]
 [    0.468571] 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.495538] Switched to clocksource MIPS
 [    0.501127] NET: Registered protocol family 2
 [    0.506522] TCP established hash table entries: 1024 (order: 0, 4096
 bytes)
 [    0.513409] TCP bind hash table entries: 1024 (order: 0, 4096 bytes)
 [    0.519784] TCP: Hash tables configured (established 1024 bind 1024)
 [    0.526356] UDP hash table entries: 256 (order: 0, 4096 bytes)
 [    0.532138] UDP-Lite hash table entries: 256 (order: 0, 4096 bytes)
 [    0.538836] NET: Registered protocol family 1
 [    0.543206] PCI: CLS 0 bytes, default 32
 [    0.543622] gptu: totally 6 16-bit timers/counters
 [    0.548421] gptu: misc_register on minor 63
 [    0.552555] gptu: succeeded to request irq 126
 [    0.557047] gptu: succeeded to request irq 127
 [    0.561579] gptu: succeeded to request irq 128
 [    0.566079] gptu: succeeded to request irq 129
 [    0.570589] gptu: succeeded to request irq 130
 [    0.575103] gptu: succeeded to request irq 131
 [    0.580483] phy-xrx200 gphy-xrx200: requesting
 lantiq/vr9_phy11g_a2x.bin
 [    0.587965] phy-xrx200 gphy-xrx200: booting GPHY0 firmware at 3A00000
 [    0.594285] phy-xrx200 gphy-xrx200: booting GPHY1 firmware at 3A00000
 [    0.702080] futex hash table entries: 256 (order: -1, 3072 bytes)
 [    0.717185] squashfs: version 4.0 (2009/01/31) Phillip Lougher
 [    0.722922] jffs2: version 2.2 (NAND) (SUMMARY) (LZMA) (RTIME)
 (CMODE_PRIORITY) (c) 2001-2006 Red Hat, Inc.
 [    0.734475] io scheduler noop registered
 [    0.738320] io scheduler deadline registered (default)
 [    0.744216] 1e100c00.serial: ttyLTQ0 at MMIO 0x1e100c00 (irq = 112,
 base_baud = 0) is a lantiq,asc
 [    0.753107] console [ttyLTQ0] enabled
 [    0.760440] bootconsole [early0] disabled
 [    0.773515] m25p80 spi32766.3: s25fl064k (8192 Kbytes)
 [    0.777281] 4 ofpart partitions found on MTD device spi32766.3
 [    0.783055] Creating 4 MTD partitions on "spi32766.3":
 [    0.788198] 0x000000000000-0x000000020000 : "u-boot"
 [    0.794266] 0x000000020000-0x0000007c0000 : "firmware"
 [    0.800997] 0x0000001bc8ac-0x0000007c0000 : "rootfs"
 [    0.805635] mtd: device 2 (rootfs) set to be root filesystem
 [    0.811085] 1 squashfs-split partitions found on MTD device rootfs
 [    0.816411] 0x0000005b0000-0x0000007c0000 : "rootfs_data"
 [    0.893694] 0x0000007c0000-0x0000007d0000 : "config"
 [    0.898341] 0x0000007d0000-0x000000800000 : "boardconfig"
 [    0.903830] Lantiq SoC SPI controller rev 8 (TXFS 8, RXFS 8, DMA 1)
 [    1.011373] libphy: lantiq,xrx200-mdio: probed
 [    1.084272] eth0: attached PHY [Lantiq XWAY PEF7071] (phy_addr=0:00,
 irq=-1)
 [    1.152244] eth0: attached PHY [Lantiq XWAY PEF7071] (phy_addr=0:05,
 irq=-1)
 [    1.220235] eth0: attached PHY [Lantiq XWAY VR9 GPHY 11G v1.4]
 (phy_addr=0:11, irq=-1)
 [    1.288227] eth0: attached PHY [Lantiq XWAY VR9 GPHY 11G v1.4]
 (phy_addr=0:13, irq=-1)
 [    1.296097] wdt 1f8803f0.watchdog: Init done
 [    1.300948] NET: Registered protocol family 10
 [    1.307405] NET: Registered protocol family 17
 [    1.310537] bridge: automatic filtering via arp/ip/ip6tables has been
 deprecated. Update your scripts to load br_netfilter if you need this.
 [    1.323067] 8021q: 802.1Q VLAN Support v1.8
 [    1.329564] ath9k,eeprom ath9k_eep: using led pin 0.
 [    1.333119] ath9k,eeprom ath9k_eep: loaded ath9k eeprom
 [    1.342588] UBIFS error (pid: 1): cannot open "ubi0:rootfs", error -19
 [    1.353342] VFS: Mounted root (squashfs filesystem) readonly on device
 31:2.
 [    1.359845] Freeing unused kernel memory: 188K (804d1000 - 80500000)
 [    1.388599] random: nonblocking pool is initialized
 [    2.659604] init: Console is alive
 [    2.661845] init: - watchdog -
 [    4.213028] dwc2 1e101000.ifxhcd: requested GPIO 489
 [    4.247688] eth0: port 2 got link
 [    5.071733] dwc2 1e101000.ifxhcd: DWC OTG Controller
 [    5.075303] dwc2 1e101000.ifxhcd: new USB bus registered, assigned bus
 number 1
 [    5.082641] dwc2 1e101000.ifxhcd: irq 62, io mem 0x00000000
 [    5.088166] dwc2 1e101000.ifxhcd: Hardware does not support descriptor
 DMA mode -
 [    5.095608] dwc2 1e101000.ifxhcd: falling back to buffer DMA mode.
 [    5.102936] hub 1-0:1.0: USB hub found
 [    5.106029] hub 1-0:1.0: 1 port detected
 [    5.967742] dwc2 1e106000.ifxhcd: DWC OTG Controller
 [    5.971310] dwc2 1e106000.ifxhcd: new USB bus registered, assigned bus
 number 2
 [    5.978647] dwc2 1e106000.ifxhcd: irq 91, io mem 0x00000000
 [    5.984172] dwc2 1e106000.ifxhcd: Hardware does not support descriptor
 DMA mode -
 [    5.991615] dwc2 1e106000.ifxhcd: falling back to buffer DMA mode.
 [    5.998963] hub 2-0:1.0: USB hub found
 [    6.002021] hub 2-0:1.0: 1 port detected
 [    6.731671] init: - preinit -
 [   10.530063] 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.
 [   10.546561] mount_root: switching to jffs2 overlay
 [   10.586775] procd: - early -
 [   10.588536] procd: - watchdog -
 [   11.247576] eth0: port 2 lost link
 [   11.364963] procd: - ubus -
 [   12.379615] procd: - init -
 [   13.344688] IFXOS, Version 1.5.19 (c) Copyright 2009, Lantiq
 Deutschland GmbH
 [   13.354713] NET: Registered protocol family 8
 [   13.357676] NET: Registered protocol family 20
 [   13.366837] tun: Universal TUN/TAP device driver, 1.6
 [   13.370497] tun: (C) 1999-2004 Max Krasnyansky <[email protected]>
 [   13.394224] PPP generic driver version 2.4.2
 [   13.413103] ip6_tables: (C) 2000-2006 Netfilter Core Team
 [   13.454550] Lantiq (VRX) DSL CPE MEI driver, version 1.4.8.5, (c) 2013
 Lantiq Deutschland GmbH
 [   13.454550]
 [   13.454550] Lantiq CPE API Driver version: DSL CPE API V4.16.6.3
 [   13.509999]
 [   13.509999] Predefined debug level: 3
 [   13.551459] u32 classifier
 [   13.552764]     input device check on
 [   13.556377]     Actions configured
 [   13.583813] Mirror/redirect action on
 [   13.607263] nf_conntrack version 0.5.0 (933 buckets, 3732 max)
 [   13.620951] Loading modules backported from Linux version
 master-2015-12-03-0-g1677f62
 [   13.627479] Backport generated by backports.git
 backports-20151120-0-g906a6b3
 [   13.638273] ip_tables: (C) 2000-2006 Netfilter Core Team
 [   13.650924] Infineon Technologies DEU driver version 2.0.0
 [   13.656837] IFX DEU DES initialized (multiblock).
 [   13.661047] IFX DEU AES initialized (multiblock).
 [   13.665213] IFX DEU ARC4 initialized (multiblock).
 [   13.669847] IFX DEU SHA1 initialized.
 [   13.673452] IFX DEU MD5 initialized.
 [   13.677046] IFX DEU SHA1_HMAC initialized.
 [   13.681165] IFX DEU MD5_HMAC initialized.
 [   13.705371] NET: Registered protocol family 24
 [   13.753082] xt_time: kernel timezone is -0000
 [   13.790083] cfg80211: World regulatory domain updated:
 [   13.793833] cfg80211:  DFS Master region: unset
 [   13.798142] cfg80211:   (start_freq - end_freq @ bandwidth),
 (max_antenna_gain, max_eirp), (dfs_cac_time)
 [   13.807903] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A,
 2000 mBm), (N/A)
 [   13.815908] cfg80211:   (2457000 KHz - 2482000 KHz @ 40000 KHz), (N/A,
 2000 mBm), (N/A)
 [   13.823916] cfg80211:   (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A,
 2000 mBm), (N/A)
 [   13.831927] cfg80211:   (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000
 KHz AUTO), (N/A, 2000 mBm), (N/A)
 [   13.841425] cfg80211:   (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000
 KHz AUTO), (N/A, 2000 mBm), (0 s)
 [   13.850901] cfg80211:   (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A,
 2000 mBm), (0 s)
 [   13.858993] cfg80211:   (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A,
 2000 mBm), (N/A)
 [   13.867001] cfg80211:   (57240000 KHz - 63720000 KHz @ 2160000 KHz),
 (N/A, 0 mBm), (N/A)
 [   13.991046] PCI: Enabling device 0000:00:00.0 (0000 -> 0002)
 [   13.995381] PCI: Enabling device 0000:01:00.0 (0000 -> 0002)
 [   14.005901] ath: EEPROM regdomain: 0x0
 [   14.005925] ath: EEPROM indicates default country code should be used
 [   14.005936] ath: doing EEPROM country->regdmn map search
 [   14.005958] ath: country maps to regdmn code: 0x3a
 [   14.005970] ath: Country alpha2 being used: US
 [   14.005981] ath: Regpair used: 0x3a
 [   14.015503] ieee80211 phy0: Selected rate control algorithm
 'minstrel_ht'
 [   14.018883] ieee80211 phy0: Atheros AR9300 Rev:3 mem=0xbc000000,
 irq=144
 [   14.027149] cfg80211: Regulatory domain changed to country: US
 [   14.031605] cfg80211:  DFS Master region: FCC
 [   14.035735] cfg80211:   (start_freq - end_freq @ bandwidth),
 (max_antenna_gain, max_eirp), (dfs_cac_time)
 [   14.045495] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A,
 3000 mBm), (N/A)
 [   14.053505] cfg80211:   (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000
 KHz AUTO), (N/A, 2300 mBm), (N/A)
 [   14.062992] cfg80211:   (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000
 KHz AUTO), (N/A, 2300 mBm), (0 s)
 [   14.072477] cfg80211:   (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A,
 2300 mBm), (0 s)
 [   14.080571] cfg80211:   (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A,
 3000 mBm), (N/A)
 [   14.088578] cfg80211:   (57240000 KHz - 63720000 KHz @ 2160000 KHz),
 (N/A, 4000 mBm), (N/A)
 [   20.608799] PTM 1.0.27    PTM (E1) firmware version 0.30
 [   20.612723] ifxmips_ptm: PTM init succeed
 [   25.996997] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
 [   26.033355] device eth0.1 entered promiscuous mode
 [   26.036812] device eth0 entered promiscuous mode
 [   26.064981] IPv6: ADDRCONF(NETDEV_UP): br-lan: link is not ready
 [   26.451807] eth0: port 2 got link
 [   26.453833] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
 [   26.467819] br-lan: port 1(eth0.1) entered forwarding state
 [   26.472052] br-lan: port 1(eth0.1) entered forwarding state
 [   26.509071] IPv6: ADDRCONF(NETDEV_CHANGE): br-lan: link becomes ready
 [   27.452351] br-lan: port 1(eth0.1) entered disabled state
 [   28.452518] br-lan: port 1(eth0.1) entered forwarding state
 [   28.456753] br-lan: port 1(eth0.1) entered forwarding state
 [   30.459606] br-lan: port 1(eth0.1) entered forwarding state
 [   70.239113] enter showtime
 [   70.244358] enter showtime
 [  139.674437] device ptm0 entered promiscuous mode
 [  141.291995] pppoe-wan: renamed from ppp0
 }}}

 {{{
 Tue Dec  8 17:34:24 2015 user.info kernel: [   10.586775] procd: - early -
 Tue Dec  8 17:34:24 2015 user.info kernel: [   10.588536] procd: -
 watchdog -
 Tue Dec  8 17:34:24 2015 kern.info kernel: [   11.247576] eth0: port 2
 lost link
 Tue Dec  8 17:34:24 2015 user.info kernel: [   11.364963] procd: - ubus -
 Tue Dec  8 17:34:24 2015 user.info kernel: [   12.379615] procd: - init -
 Tue Dec  8 17:34:24 2015 kern.info kernel: [   13.344688] IFXOS, Version
 1.5.19 (c) Copyright 2009, Lantiq Deutschland GmbH
 Tue Dec  8 17:34:24 2015 kern.info kernel: [   13.354713] NET: Registered
 protocol family 8
 Tue Dec  8 17:34:24 2015 kern.info kernel: [   13.357676] NET: Registered
 protocol family 20
 Tue Dec  8 17:34:24 2015 kern.info kernel: [   13.366837] tun: Universal
 TUN/TAP device driver, 1.6
 Tue Dec  8 17:34:24 2015 kern.info kernel: [   13.370497] tun: (C)
 1999-2004 Max Krasnyansky <[email protected]>
 Tue Dec  8 17:34:24 2015 kern.info kernel: [   13.394224] PPP generic
 driver version 2.4.2
 Tue Dec  8 17:34:24 2015 kern.info kernel: [   13.413103] ip6_tables: (C)
 2000-2006 Netfilter Core Team
 Tue Dec  8 17:34:24 2015 kern.info kernel: [   13.454550] Lantiq (VRX) DSL
 CPE MEI driver, version 1.4.8.5, (c) 2013 Lantiq Deutschland GmbH
 Tue Dec  8 17:34:24 2015 kern.info kernel: [   13.454550]
 Tue Dec  8 17:34:24 2015 kern.info kernel: [   13.454550] Lantiq CPE API
 Driver version: DSL CPE API V4.16.6.3
 Tue Dec  8 17:34:24 2015 kern.warn kernel: [   13.509999]
 Tue Dec  8 17:34:24 2015 kern.warn kernel: [   13.509999] Predefined debug
 level: 3
 Tue Dec  8 17:34:24 2015 kern.info kernel: [   13.551459] u32 classifier
 Tue Dec  8 17:34:24 2015 kern.info kernel: [   13.552764]     input device
 check on
 Tue Dec  8 17:34:24 2015 kern.info kernel: [   13.556377]     Actions
 configured
 Tue Dec  8 17:34:24 2015 kern.info kernel: [   13.583813] Mirror/redirect
 action on
 Tue Dec  8 17:34:24 2015 kern.info kernel: [   13.607263] nf_conntrack
 version 0.5.0 (933 buckets, 3732 max)
 Tue Dec  8 17:34:24 2015 kern.info kernel: [   13.620951] Loading modules
 backported from Linux version master-2015-12-03-0-g1677f62
 Tue Dec  8 17:34:24 2015 kern.info kernel: [   13.627479] Backport
 generated by backports.git backports-20151120-0-g906a6b3
 Tue Dec  8 17:34:24 2015 kern.info kernel: [   13.638273] ip_tables: (C)
 2000-2006 Netfilter Core Team
 Tue Dec  8 17:34:24 2015 kern.info kernel: [   13.650924] Infineon
 Technologies DEU driver version 2.0.0
 Tue Dec  8 17:34:24 2015 kern.notice kernel: [   13.656837] IFX DEU DES
 initialized (multiblock).
 Tue Dec  8 17:34:24 2015 kern.notice kernel: [   13.661047] IFX DEU AES
 initialized (multiblock).
 Tue Dec  8 17:34:24 2015 kern.notice kernel: [   13.665213] IFX DEU ARC4
 initialized (multiblock).
 Tue Dec  8 17:34:24 2015 kern.notice kernel: [   13.669847] IFX DEU SHA1
 initialized.
 Tue Dec  8 17:34:24 2015 kern.notice kernel: [   13.673452] IFX DEU MD5
 initialized.
 Tue Dec  8 17:34:24 2015 kern.notice kernel: [   13.677046] IFX DEU
 SHA1_HMAC initialized.
 Tue Dec  8 17:34:24 2015 kern.notice kernel: [   13.681165] IFX DEU
 MD5_HMAC initialized.
 Tue Dec  8 17:34:24 2015 kern.info kernel: [   13.705371] NET: Registered
 protocol family 24
 Tue Dec  8 17:34:24 2015 kern.info kernel: [   13.753082] xt_time: kernel
 timezone is -0000
 Tue Dec  8 17:34:24 2015 kern.info kernel: [   13.790083] cfg80211: World
 regulatory domain updated:
 Tue Dec  8 17:34:24 2015 kern.info kernel: [   13.793833] cfg80211:  DFS
 Master region: unset
 Tue Dec  8 17:34:24 2015 kern.info kernel: [   13.798142] cfg80211:
 (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp),
 (dfs_cac_time)
 Tue Dec  8 17:34:24 2015 kern.info kernel: [   13.807903] cfg80211:
 (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
 Tue Dec  8 17:34:24 2015 kern.info kernel: [   13.815908] cfg80211:
 (2457000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
 Tue Dec  8 17:34:24 2015 kern.info kernel: [   13.823916] cfg80211:
 (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm), (N/A)
 Tue Dec  8 17:34:24 2015 kern.info kernel: [   13.831927] cfg80211:
 (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm),
 (N/A)
 Tue Dec  8 17:34:24 2015 kern.info kernel: [   13.841425] cfg80211:
 (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm),
 (0 s)
 Tue Dec  8 17:34:24 2015 kern.info kernel: [   13.850901] cfg80211:
 (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A, 2000 mBm), (0 s)
 Tue Dec  8 17:34:24 2015 kern.info kernel: [   13.858993] cfg80211:
 (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A)
 Tue Dec  8 17:34:24 2015 kern.info kernel: [   13.867001] cfg80211:
 (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm), (N/A)
 Tue Dec  8 17:34:24 2015 kern.warn kernel: [   13.991046] PCI: Enabling
 device 0000:00:00.0 (0000 -> 0002)
 Tue Dec  8 17:34:24 2015 kern.warn kernel: [   13.995381] PCI: Enabling
 device 0000:01:00.0 (0000 -> 0002)
 Tue Dec  8 17:34:24 2015 kern.debug kernel: [   14.005901] ath: EEPROM
 regdomain: 0x0
 Tue Dec  8 17:34:24 2015 kern.debug kernel: [   14.005925] ath: EEPROM
 indicates default country code should be used
 Tue Dec  8 17:34:24 2015 kern.debug kernel: [   14.005936] ath: doing
 EEPROM country->regdmn map search
 Tue Dec  8 17:34:24 2015 kern.debug kernel: [   14.005958] ath: country
 maps to regdmn code: 0x3a
 Tue Dec  8 17:34:24 2015 kern.debug kernel: [   14.005970] ath: Country
 alpha2 being used: US
 Tue Dec  8 17:34:24 2015 kern.debug kernel: [   14.005981] ath: Regpair
 used: 0x3a
 Tue Dec  8 17:34:24 2015 kern.debug kernel: [   14.015503] ieee80211 phy0:
 Selected rate control algorithm 'minstrel_ht'
 Tue Dec  8 17:34:24 2015 kern.info kernel: [   14.018883] ieee80211 phy0:
 Atheros AR9300 Rev:3 mem=0xbc000000, irq=144
 Tue Dec  8 17:34:24 2015 kern.info kernel: [   14.027149] cfg80211:
 Regulatory domain changed to country: US
 Tue Dec  8 17:34:24 2015 kern.info kernel: [   14.031605] cfg80211:  DFS
 Master region: FCC
 Tue Dec  8 17:34:24 2015 kern.info kernel: [   14.035735] cfg80211:
 (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp),
 (dfs_cac_time)
 Tue Dec  8 17:34:24 2015 kern.info kernel: [   14.045495] cfg80211:
 (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 3000 mBm), (N/A)
 Tue Dec  8 17:34:24 2015 kern.info kernel: [   14.053505] cfg80211:
 (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2300 mBm),
 (N/A)
 Tue Dec  8 17:34:24 2015 kern.info kernel: [   14.062992] cfg80211:
 (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2300 mBm),
 (0 s)
 Tue Dec  8 17:34:24 2015 kern.info kernel: [   14.072477] cfg80211:
 (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A, 2300 mBm), (0 s)
 Tue Dec  8 17:34:24 2015 kern.info kernel: [   14.080571] cfg80211:
 (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 3000 mBm), (N/A)
 Tue Dec  8 17:34:24 2015 kern.info kernel: [   14.088578] cfg80211:
 (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 4000 mBm), (N/A)
 Tue Dec  8 17:34:26 2015 user.notice : 'radio0' is disabled
 Tue Dec  8 17:34:26 2015 user.notice : 'radio0' is disabled
 Tue Dec  8 17:34:28 2015 kern.info kernel: [   20.608799] PTM 1.0.27
 PTM (E1) firmware version 0.30
 Tue Dec  8 17:34:28 2015 kern.warn kernel: [   20.612723] ifxmips_ptm: PTM
 init succeed
 Tue Dec  8 17:34:30 2015 authpriv.info dropbear[899]: Not backgrounding
 Tue Dec  8 17:34:32 2015 daemon.err insmod: module is already loaded -
 xt_multiport
 Tue Dec  8 17:34:32 2015 daemon.err insmod: module is already loaded -
 xt_comment
 Tue Dec  8 17:34:32 2015 daemon.err insmod: module is already loaded -
 xt_length
 Tue Dec  8 17:34:33 2015 kern.info kernel: [   25.996997] IPv6:
 ADDRCONF(NETDEV_UP): eth0: link is not ready
 Tue Dec  8 17:34:33 2015 kern.info kernel: [   26.033355] device eth0.1
 entered promiscuous mode
 Tue Dec  8 17:34:33 2015 kern.info kernel: [   26.036812] device eth0
 entered promiscuous mode
 Tue Dec  8 17:34:33 2015 kern.info kernel: [   26.064981] IPv6:
 ADDRCONF(NETDEV_UP): br-lan: link is not ready
 Tue Dec  8 17:34:33 2015 daemon.notice netifd: Interface 'lan' is enabled
 Tue Dec  8 17:34:33 2015 daemon.notice netifd: Interface 'lan' is setting
 up now
 Tue Dec  8 17:34:33 2015 daemon.notice netifd: Interface 'lan' is now up
 Tue Dec  8 17:34:33 2015 daemon.notice netifd: Interface 'loopback' is
 enabled
 Tue Dec  8 17:34:33 2015 daemon.notice netifd: Interface 'loopback' is
 setting up now
 Tue Dec  8 17:34:33 2015 daemon.notice netifd: Interface 'loopback' is now
 up
 Tue Dec  8 17:34:33 2015 daemon.notice netifd: Network device 'lo' link is
 up
 Tue Dec  8 17:34:33 2015 daemon.notice netifd: Interface 'loopback' has
 link connectivity
 Tue Dec  8 17:34:34 2015 kern.info kernel: [   26.451807] eth0: port 2 got
 link
 Tue Dec  8 17:34:34 2015 kern.info kernel: [   26.453833] IPv6:
 ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
 Tue Dec  8 17:34:34 2015 daemon.notice netifd: VLAN 'eth0.1' link is up
 Tue Dec  8 17:34:34 2015 daemon.notice netifd: Network device 'eth0' link
 is up
 Tue Dec  8 17:34:34 2015 kern.info kernel: [   26.467819] br-lan: port
 1(eth0.1) entered forwarding state
 Tue Dec  8 17:34:34 2015 kern.info kernel: [   26.472052] br-lan: port
 1(eth0.1) entered forwarding state
 Tue Dec  8 17:34:34 2015 daemon.notice netifd: Bridge 'br-lan' link is up
 Tue Dec  8 17:34:34 2015 daemon.notice netifd: Interface 'lan' has link
 connectivity
 Tue Dec  8 17:34:34 2015 kern.info kernel: [   26.509071] IPv6:
 ADDRCONF(NETDEV_CHANGE): br-lan: link becomes ready
 Tue Dec  8 17:34:35 2015 daemon.err insmod: module is already loaded -
 xt_multiport
 Tue Dec  8 17:34:35 2015 daemon.notice netifd: Network device 'eth0' link
 is down
 Tue Dec  8 17:34:35 2015 daemon.notice netifd: VLAN 'eth0.1' link is down
 Tue Dec  8 17:34:35 2015 kern.info kernel: [   27.452351] br-lan: port
 1(eth0.1) entered disabled state
 Tue Dec  8 17:34:35 2015 daemon.err insmod: module is already loaded -
 xt_comment
 Tue Dec  8 17:34:35 2015 daemon.err insmod: module is already loaded -
 xt_length
 Tue Dec  8 17:34:35 2015 user.notice firewall: Reloading firewall due to
 ifup of lan (br-lan)
 Tue Dec  8 17:34:35 2015 user.notice : iptables: Resource temporarily
 unavailable.
 Tue Dec  8 17:34:36 2015 kern.info kernel: [   28.452518] br-lan: port
 1(eth0.1) entered forwarding state
 Tue Dec  8 17:34:36 2015 kern.info kernel: [   28.456753] br-lan: port
 1(eth0.1) entered forwarding state
 Tue Dec  8 17:34:36 2015 daemon.notice netifd: Network device 'eth0' link
 is up
 Tue Dec  8 17:34:36 2015 daemon.notice netifd: VLAN 'eth0.1' link is up
 Tue Dec  8 17:34:38 2015 kern.info kernel: [   30.459606] br-lan: port
 1(eth0.1) entered forwarding state
 Tue Dec  8 17:34:38 2015 daemon.info zabbix_agentd[1251]: Starting Zabbix
 Agent [OpenWrt]. Zabbix 2.4.6 (revision 54796).
 Tue Dec  8 17:34:38 2015 daemon.info zabbix_agentd[1251]: using
 configuration file: /etc/zabbix_agentd.conf
 Tue Dec  8 17:34:38 2015 daemon.info zabbix_agentd[1251]: agent #0 started
 [main process]
 Tue Dec  8 17:34:38 2015 daemon.info zabbix_agentd[1261]: agent #2 started
 [listener #1]
 Tue Dec  8 17:34:38 2015 daemon.info zabbix_agentd[1260]: agent #1 started
 [collector]
 Tue Dec  8 17:34:38 2015 user.notice : setting up led usb
 Tue Dec  8 17:34:38 2015 user.notice : setting up led usb2
 Tue Dec  8 17:34:38 2015 user.notice : setting up led internet
 Tue Dec  8 17:34:38 2015 user.notice : setting up led dsl
 Tue Dec  8 17:34:38 2015 user.notice : setting up led wps
 Tue Dec  8 17:34:39 2015 daemon.info procd: - init complete -
 Tue Dec  8 17:34:41 2015 daemon.info dnsmasq[1351]: started, version 2.75
 cachesize 150
 Tue Dec  8 17:34:41 2015 daemon.info dnsmasq[1351]: 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 loop-detect inotify
 Tue Dec  8 17:34:41 2015 daemon.info dnsmasq[1351]: DNS service limited to
 local subnets
 Tue Dec  8 17:34:41 2015 daemon.info dnsmasq-dhcp[1351]: DHCP, IP range
 192.168.1.100 -- 192.168.1.249, lease time 12h
 Tue Dec  8 17:34:41 2015 daemon.info dnsmasq[1351]: using local addresses
 only for domain lan
 Tue Dec  8 17:34:41 2015 daemon.warn dnsmasq[1351]: no servers found in
 /tmp/resolv.conf.auto, will retry
 Tue Dec  8 17:34:41 2015 daemon.info dnsmasq[1351]: read /etc/hosts - 4
 addresses
 Tue Dec  8 17:34:41 2015 daemon.info dnsmasq[1351]: read /tmp/hosts/dhcp -
 1 addresses
 Tue Dec  8 17:34:41 2015 daemon.info dnsmasq-dhcp[1351]: read /etc/ethers
 - 0 addresses
 Tue Dec  8 17:34:42 2015 daemon.warn odhcpd[810]: DHCPV6 SOLICIT IA_NA
 from 000100011d63f4e488ae1d577e55 on br-lan: ok fd86:be0e:6396::c2c/128
 Tue Dec  8 17:34:42 2015 daemon.warn odhcpd[810]: DHCPV6 REQUEST IA_NA
 from 000100011d63f4e488ae1d577e55 on br-lan: ok fd86:be0e:6396::c2c/128
 Tue Dec  8 17:34:43 2015 daemon.info dnsmasq-dhcp[1351]: DHCPREQUEST(br-
 lan) 192.168.1.139 88:ae:1d:57:7e:55
 Tue Dec  8 17:34:43 2015 daemon.info dnsmasq-dhcp[1351]: DHCPACK(br-lan)
 192.168.1.139 88:ae:1d:57:7e:55 dan10alm
 Tue Dec  8 17:34:44 2015 daemon.warn odhcpd[810]: DHCPV6 CONFIRM IA_NA
 from 000100011d63f4e488ae1d577e55 on br-lan: not on-link
 fd86:be0e:6396::c2c/128
 Tue Dec  8 17:34:44 2015 daemon.warn odhcpd[810]: DHCPV6 SOLICIT IA_NA
 from 000100011d63f4e488ae1d577e55 on br-lan: ok fd86:be0e:6396::c2c/128
 Tue Dec  8 17:34:44 2015 daemon.info dnsmasq[1351]: read /etc/hosts - 4
 addresses
 Tue Dec  8 17:34:44 2015 daemon.info dnsmasq[1351]: read /tmp/hosts/odhcpd
 - 0 addresses
 Tue Dec  8 17:34:44 2015 daemon.info dnsmasq[1351]: read /tmp/hosts/dhcp -
 1 addresses
 Tue Dec  8 17:34:44 2015 daemon.info dnsmasq-dhcp[1351]: read /etc/ethers
 - 0 addresses
 Tue Dec  8 17:34:45 2015 daemon.warn odhcpd[810]: DHCPV6 REQUEST IA_NA
 from 000100011d63f4e488ae1d577e55 on br-lan: ok fd86:be0e:6396::c2c/128
 Tue Dec  8 17:34:45 2015 daemon.info dnsmasq[1351]: read /etc/hosts - 4
 addresses
 Tue Dec  8 17:34:45 2015 daemon.info dnsmasq[1351]: read /tmp/hosts/odhcpd
 - 1 addresses
 Tue Dec  8 17:34:45 2015 daemon.info dnsmasq[1351]: read /tmp/hosts/dhcp -
 1 addresses
 Tue Dec  8 17:34:45 2015 daemon.info dnsmasq-dhcp[1351]: read /etc/ethers
 - 0 addresses
 Tue Dec  8 17:35:18 2015 kern.warn kernel: [   70.239113] enter showtime
 Tue Dec  8 17:35:18 2015 kern.warn kernel: [   70.244358] enter showtime
 Tue Dec  8 17:36:27 2015 kern.info kernel: [  139.674437] device ptm0
 entered promiscuous mode
 Tue Dec  8 17:36:27 2015 daemon.notice netifd: Interface 'wan' is enabled
 Tue Dec  8 17:36:27 2015 daemon.notice netifd: Network device 'ptm0' link
 is up
 Tue Dec  8 17:36:27 2015 daemon.notice netifd: VLAN 'ptm0.835' link is up
 Tue Dec  8 17:36:27 2015 daemon.notice netifd: Interface 'wan' has link
 connectivity
 Tue Dec  8 17:36:27 2015 daemon.notice netifd: Interface 'wan' is setting
 up now
 Tue Dec  8 17:36:28 2015 daemon.info pppd[4842]: Plugin rp-pppoe.so
 loaded.
 Tue Dec  8 17:36:28 2015 daemon.info pppd[4842]: RP-PPPoE plugin version
 3.8p compiled against pppd 2.4.7
 Tue Dec  8 17:36:28 2015 daemon.notice pppd[4842]: pppd 2.4.7 started by
 root, uid 0
 Tue Dec  8 17:36:29 2015 daemon.info pppd[4842]: PPP session is 5171
 Tue Dec  8 17:36:29 2015 daemon.warn pppd[4842]: Connected to
 88:a2:5e:17:be:be via interface ptm0.835
 Tue Dec  8 17:36:29 2015 kern.info kernel: [  141.291995] pppoe-wan:
 renamed from ppp0
 Tue Dec  8 17:36:29 2015 daemon.info pppd[4842]: Using interface pppoe-wan
 Tue Dec  8 17:36:29 2015 daemon.notice pppd[4842]: Connect: pppoe-wan <-->
 ptm0.835
 Tue Dec  8 17:36:29 2015 daemon.info pppd[4842]: Remote message: REASON021
 - TK MISSING: NOT IN DSL-LINE
 Tue Dec  8 17:36:29 2015 daemon.notice pppd[4842]: PAP authentication
 succeeded
 Tue Dec  8 17:36:29 2015 daemon.notice pppd[4842]: peer from calling
 number 88:A2:5E:17:BE:BE authorized
 Tue Dec  8 17:36:29 2015 daemon.notice netifd: Network device 'pppoe-wan'
 link is up
 Tue Dec  8 17:36:29 2015 daemon.notice netifd: Interface 'wan6' has link
 connectivity
 Tue Dec  8 17:36:29 2015 daemon.notice pppd[4842]: local  IP address
 79.36.225.202
 Tue Dec  8 17:36:29 2015 daemon.notice pppd[4842]: remote IP address
 192.168.100.1
 Tue Dec  8 17:36:29 2015 daemon.notice pppd[4842]: primary   DNS address
 85.37.17.17
 Tue Dec  8 17:36:29 2015 daemon.notice pppd[4842]: secondary DNS address
 85.38.28.72
 Tue Dec  8 17:36:29 2015 daemon.notice pppd[4842]: local  LL address
 fe80::1d09:16d8:fcc8:8e50
 Tue Dec  8 17:36:29 2015 daemon.notice pppd[4842]: remote LL address
 fe80::02a0:a50f:fc86:8004
 Tue Dec  8 17:36:29 2015 daemon.info pppd[4842]: IPV6CP terminated by peer
 Tue Dec  8 17:36:29 2015 daemon.notice netifd: Interface 'wan6' is enabled
 Tue Dec  8 17:36:29 2015 daemon.notice netifd: Interface 'wan6' is setting
 up now
 Tue Dec  8 17:36:29 2015 daemon.notice netifd: Interface 'wan' is now up
 Tue Dec  8 17:36:29 2015 daemon.info dnsmasq[1351]: reading
 /tmp/resolv.conf.auto
 Tue Dec  8 17:36:29 2015 daemon.info dnsmasq[1351]: using local addresses
 only for domain lan
 Tue Dec  8 17:36:29 2015 daemon.info dnsmasq[1351]: using nameserver
 85.37.17.17#53
 Tue Dec  8 17:36:29 2015 daemon.info dnsmasq[1351]: using nameserver
 85.38.28.72#53
 Tue Dec  8 17:36:30 2015 daemon.notice netifd: Network alias 'pppoe-wan'
 link is up
 Tue Dec  8 17:36:30 2015 daemon.notice netifd: Interface 'wan_6' is
 enabled
 Tue Dec  8 17:36:30 2015 daemon.notice netifd: Interface 'wan_6' has link
 connectivity
 Tue Dec  8 17:36:30 2015 daemon.notice netifd: Interface 'wan_6' is
 setting up now
 Tue Dec  8 17:36:30 2015 daemon.info dnsmasq[1351]: reading
 /tmp/resolv.conf.auto
 Tue Dec  8 17:36:30 2015 daemon.info dnsmasq[1351]: using local addresses
 only for domain lan
 Tue Dec  8 17:36:30 2015 daemon.info dnsmasq[1351]: using nameserver
 85.37.17.17#53
 Tue Dec  8 17:36:30 2015 daemon.info dnsmasq[1351]: using nameserver
 85.38.28.72#53
 Tue Dec  8 17:36:30 2015 daemon.info dnsmasq[1351]: using nameserver
 85.37.17.17#53
 Tue Dec  8 17:36:30 2015 daemon.info dnsmasq[1351]: using nameserver
 85.38.28.72#53
 Tue Dec  8 17:36:30 2015 daemon.notice netifd: Interface 'wan' has lost
 the connection
 Tue Dec  8 17:36:30 2015 daemon.warn dnsmasq[1351]: no servers found in
 /tmp/resolv.conf.auto, will retry
 Tue Dec  8 17:36:30 2015 daemon.notice netifd: Interface 'wan_6' is now
 down
 Tue Dec  8 17:36:30 2015 daemon.notice netifd: Interface 'wan_6' is
 disabled
 Tue Dec  8 17:36:30 2015 daemon.notice netifd: Interface 'wan_6' has link
 connectivity loss
 Tue Dec  8 17:36:31 2015 user.notice firewall: Reloading firewall due to
 ifup of wan (pppoe-wan)
 Tue Dec  8 17:36:32 2015 daemon.err insmod: module is already loaded -
 xt_multiport
 Tue Dec  8 17:36:32 2015 daemon.err insmod: module is already loaded -
 xt_comment
 Tue Dec  8 17:36:32 2015 daemon.err insmod: module is already loaded -
 xt_length
 Tue Dec  8 17:36:34 2015 user.notice ddns-scripts[5139]: myddns_ipv4: PID
 '5139' started at 2015-12-08 17:36
 Tue Dec  8 17:36:34 2015 user.warn ddns-scripts[5139]: myddns_ipv4:
 Service section disabled! - TERMINATE
 Tue Dec  8 17:36:34 2015 user.warn ddns-scripts[5139]: myddns_ipv4: PID
 '5139' exit WITH ERROR '1' at 2015-12-08 17:36
 }}}

 pppoe authentication is ok, there is connection on the pppoe-wan interface
 but wan "lost connection".

 Let me know how can I do...

 Thanks
 D.

--
Ticket URL: <https://dev.openwrt.org/ticket/21319#comment:10>
OpenWrt <http://openwrt.org>
Opensource Wireless Router Technology
_______________________________________________
openwrt-tickets mailing list
[email protected]
https://lists.openwrt.org/cgi-bin/mailman/listinfo/openwrt-tickets

Reply via email to