Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

FS#296 - Ubiquiti Bullet M 10/100 ethernet interface comes up as gigabit, doesn't work #6612

Closed
openwrt-bot opened this issue Nov 21, 2016 · 21 comments
Labels

Comments

@openwrt-bot
Copy link

russell:

For the last month or so, and persisting in r2248, when a Ubiquiti Bullet M is booted through typical Ubiquiti 10/100 passive PoE injector, the interface appears to come up in gigabit mode (see timestamp 18.990274 below), despite being only a 10/100 Mbps interface. Restarting /etc/init.d/network fixes it. I am running batman-adv over the ethernet interface, which may be involved. I will check if it happens when batman-adv is not used on the interface and report in a followup comment.

The dmesg look like this:

[ 0.000000] Linux version 4.4.32 (openwrt@hawg) (gcc version 5.4.0 (LEDE GCC 5.4.0 r1439) ) #0 Mon Nov 21 07:14:51 2016
[ 0.000000] MyLoader: sysp=00030800, boardp=088201a0, parts=fdeffeff
[ 0.000000] bootconsole [early0] enabled
[ 0.000000] CPU0 revision is: 00019374 (MIPS 24Kc)
[ 0.000000] SoC: Atheros AR7240 rev 2
[ 0.000000] Determined physical RAM map:
[ 0.000000] memory: 02000000 @ 00000000 (usable)
[ 0.000000] Initrd not found or empty - disabling initrd
[ 0.000000] No valid device tree found, continuing without
[ 0.000000] Zone ranges:
[ 0.000000] Normal [mem 0x0000000000000000-0x0000000001ffffff]
[ 0.000000] Movable zone start for each node
[ 0.000000] Early memory node ranges
[ 0.000000] node 0: [mem 0x0000000000000000-0x0000000001ffffff]
[ 0.000000] Initmem setup node 0 [mem 0x0000000000000000-0x0000000001ffffff]
[ 0.000000] On node 0 totalpages: 8192
[ 0.000000] free_area_init_node: node 0, pgdat 80412320, node_mem_map 81000000
[ 0.000000] Normal zone: 64 pages used for memmap
[ 0.000000] Normal zone: 0 pages reserved
[ 0.000000] Normal zone: 8192 pages, LIFO batch:0
[ 0.000000] Primary instruction cache 64kB, 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: 8128
[ 0.000000] Kernel command line: board=UBNT-BM mtdparts=spi0.0:256k(u-boot)ro,64k(u-boot-env)ro,7552k(firmware),256k(cfg)ro,64k(EEPROM)ro console=ttyS0,115200 rootfstype=squashfs,jffs2 noinitrd
[ 0.000000] PID hash table entries: 128 (order: -3, 512 bytes)
[ 0.000000] Dentry cache hash table entries: 4096 (order: 2, 16384 bytes)
[ 0.000000] Inode-cache hash table entries: 2048 (order: 1, 8192 bytes)
[ 0.000000] Writing ErrCtl register=00000000
[ 0.000000] Readback ErrCtl register=00000000
[ 0.000000] Memory: 27616K/32768K available (2990K kernel code, 174K rwdata, 756K rodata, 296K init, 198K bss, 5152K reserved, 0K cma-reserved)
[ 0.000000] SLUB: HWalign=32, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
[ 0.000000] NR_IRQS:51
[ 0.000000] Clocks: CPU:390.000MHz, DDR:390.000MHz, AHB:195.000MHz, Ref:40.000MHz
[ 0.000000] clocksource: MIPS: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 9801335621 ns
[ 0.000013] sched_clock: 32 bits at 195MHz, resolution 5ns, wraps every 11012737021ns
[ 0.007858] Calibrating delay loop... 259.27 BogoMIPS (lpj=1296384)
[ 0.080537] pid_max: default: 32768 minimum: 301
[ 0.085319] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes)
[ 0.091915] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes)
[ 0.102739] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[ 0.113516] NET: Registered protocol family 16
[ 0.120053] MIPS: machine is Ubiquiti Bullet M
[ 0.126714] registering PCI controller with io_map_base unset
[ 0.357171] PCI host bridge to bus 0000:00
[ 0.361273] pci_bus 0000:00: root bus resource [mem 0x10000000-0x13ffffff]
[ 0.368174] pci_bus 0000:00: root bus resource [io 0x0000]
[ 0.373719] pci_bus 0000:00: root bus resource [??? 0x00000000 flags 0x0]
[ 0.380486] pci_bus 0000:00: No busn resource found for root bus, will use [bus 00-ff]
[ 0.388422] pci 0000:00:00.0: [168c:002a] type 00 class 0x028000
[ 0.388466] pci 0000:00:00.0: fixup device configuration
[ 0.395018] pci 0000:00:00.0: reg 0x10: [mem 0x00000000-0x0000ffff 64bit]
[ 0.395154] pci 0000:00:00.0: supports D1
[ 0.395179] pci 0000:00:00.0: PME# supported from D0 D1 D3hot
[ 0.395521] pci_bus 0000:00: busn_res: [bus 00-ff] end is updated to 00
[ 0.395573] pci 0000:00:00.0: BAR 0: assigned [mem 0x10000000-0x1000ffff 64bit]
[ 0.402864] pci 0000:00:00.0: using irq 40 for pin 1
[ 0.408959] clocksource: Switched to clocksource MIPS
[ 0.415845] NET: Registered protocol family 2
[ 0.421435] TCP established hash table entries: 1024 (order: 0, 4096 bytes)
[ 0.428393] TCP bind hash table entries: 1024 (order: 0, 4096 bytes)
[ 0.434796] TCP: Hash tables configured (established 1024 bind 1024)
[ 0.441291] UDP hash table entries: 256 (order: 0, 4096 bytes)
[ 0.447126] UDP-Lite hash table entries: 256 (order: 0, 4096 bytes)
[ 0.453786] NET: Registered protocol family 1
[ 0.458221] PCI: CLS 0 bytes, default 32
[ 0.464223] futex hash table entries: 256 (order: -1, 3072 bytes)
[ 0.470512] Crashlog allocated RAM at address 0x1f00000
[ 0.495166] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[ 0.501050] jffs2: version 2.2 (NAND) (SUMMARY) (LZMA) (RTIME) (CMODE_PRIORITY) (c) 2001-2006 Red Hat, Inc.
[ 0.514332] io scheduler noop registered
[ 0.518252] io scheduler deadline registered (default)
[ 0.523724] Serial: 8250/16550 driver, 1 ports, IRQ sharing disabled
[ 0.530709] console [ttyS0] disabled
[ 0.554342] serial8250.0: ttyS0 at MMIO 0x18020000 (irq = 11, base_baud = 12187500) is a 16550A
[ 0.563020] console [ttyS0] enabled
[ 0.570030] bootconsole [early0] disabled
[ 0.582486] m25p80 spi0.0: found mx25l6405d, expected m25p80
[ 0.588201] m25p80 spi0.0: mx25l6405d (8192 Kbytes)
[ 0.593207] 5 cmdlinepart partitions found on MTD device spi0.0
[ 0.599160] Creating 5 MTD partitions on "spi0.0":
[ 0.603978] 0x000000000000-0x000000040000 : "u-boot"
[ 0.611975] 0x000000040000-0x000000050000 : "u-boot-env"
[ 0.619659] 0x000000050000-0x0000007b0000 : "firmware"
[ 0.638850] 2 uimage-fw partitions found on MTD device firmware
[ 0.644866] 0x000000050000-0x0000001a0000 : "kernel"
[ 0.651748] 0x0000001a0000-0x0000007b0000 : "rootfs"
[ 0.658927] mtd: device 4 (rootfs) set to be root filesystem
[ 0.664753] 1 squashfs-split partitions found on MTD device rootfs
[ 0.671002] 0x000000550000-0x0000007b0000 : "rootfs_data"
[ 0.678725] 0x0000007b0000-0x0000007f0000 : "cfg"
[ 0.685799] 0x0000007f0000-0x000000800000 : "EEPROM"
[ 0.713743] libphy: ag71xx_mdio: probed
[ 1.302694] ag71xx ag71xx.0: connected to PHY at ag71xx-mdio.0:04 [uid=004dd041, driver=Generic PHY]
[ 1.312905] eth0: Atheros AG71xx at 0xb9000000, irq 4, mode:MII
[ 1.322158] NET: Registered protocol family 10
[ 1.332118] NET: Registered protocol family 17
[ 1.336691] bridge: automatic filtering via arp/ip/ip6tables has been deprecated. Update your scripts to load br_netfilter if you need this.
[ 1.349583] 8021q: 802.1Q VLAN Support v1.8
[ 1.362372] VFS: Mounted root (squashfs filesystem) readonly on device 31:4.
[ 1.372025] Freeing unused kernel memory: 296K (80436000 - 80480000)
[ 2.887723] init: Console is alive
[ 2.891524] init: - watchdog -
[ 4.278153] usbcore: registered new interface driver usbfs
[ 4.283867] usbcore: registered new interface driver hub
[ 4.289377] usbcore: registered new device driver usb
[ 4.301662] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[ 4.310384] ehci-platform: EHCI generic platform driver
[ 4.319460] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
[ 4.327414] ohci-platform: OHCI generic platform driver
[ 4.336259] init: - preinit -
[ 5.148878] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[ 5.181862] random: procd: uninitialized urandom read (4 bytes read, 8 bits of entropy available)
[ 7.440590] eth0: link up (100Mbps/Full duplex)
[ 7.445184] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[ 8.484066] jffs2: notice: (361) jffs2_build_xattr_subsystem: complete building xattr subsystem, 0 of xdatum (0 unchecked, 0 orphan) and 0 of xref (0 dead, 0 orphan) found.
[ 8.501955] mount_root: switching to jffs2 overlay
[ 8.517794] urandom-seed: Seeding with /etc/urandom.seed
[ 8.794632] eth0: link down
[ 8.814035] procd: - early -
[ 8.817063] procd: - watchdog -
[ 9.492101] procd: - ubus -
[ 9.545805] random: ubusd: uninitialized urandom read (4 bytes read, 15 bits of entropy available)
[ 9.555498] random: ubusd: uninitialized urandom read (4 bytes read, 15 bits of entropy available)
[ 9.564637] random: ubusd: uninitialized urandom read (4 bytes read, 15 bits of entropy available)
[ 9.574254] random: ubusd: uninitialized urandom read (4 bytes read, 15 bits of entropy available)
[ 9.583375] random: ubusd: uninitialized urandom read (4 bytes read, 15 bits of entropy available)
[ 9.593373] random: ubusd: uninitialized urandom read (4 bytes read, 16 bits of entropy available)
[ 9.602738] random: ubusd: uninitialized urandom read (4 bytes read, 16 bits of entropy available)
[ 9.612394] procd: - init -
[ 10.066368] Loading modules backported from Linux version wt-2016-10-03-1-g6fcb1a6
[ 10.074041] Backport generated by backports.git backports-20160324-9-g0e38f5c
[ 10.125220] batman_adv: B.A.T.M.A.N. advanced 2016.4 (compatibility version 15) loaded
[ 10.213939] PCI: Enabling device 0000:00:00.0 (0000 -> 0002)
[ 10.224958] ath: phy0: Ignoring endianness difference in EEPROM magic bytes.
[ 10.233630] ath: EEPROM regdomain: 0x0
[ 10.233647] ath: EEPROM indicates default country code should be used
[ 10.233661] ath: doing EEPROM country->regdmn map search
[ 10.233689] ath: country maps to regdmn code: 0x3a
[ 10.233705] ath: Country alpha2 being used: US
[ 10.233718] ath: Regpair used: 0x3a
[ 10.248634] ieee80211 phy0: Selected rate control algorithm 'minstrel_ht'
[ 10.257391] ieee80211 phy0: Atheros AR9280 Rev:2 mem=0xb0000000, irq=40
[ 11.870351] random: jshn: uninitialized urandom read (4 bytes read, 19 bits of entropy available)
[ 12.001559] random: ubusd: uninitialized urandom read (4 bytes read, 19 bits of entropy available)
[ 18.855427] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[ 18.875510] IPv6: ADDRCONF(NETDEV_UP): br-pub: link is not ready
[ 18.990274] eth0: link up (1000Mbps/Full duplex)
[ 18.994964] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[ 19.330349] batman_adv: bat0: Adding interface: eth0
[ 19.335365] batman_adv: bat0: The MTU of interface eth0 is too small (1500) to handle the transport of batman-adv packets. Packets going over this interface will be fragmented on layer2 which could impact the
performance. Setting the MTU to 1532 would solve the problem.
[ 19.359419] batman_adv: bat0: Interface activated: eth0
[ 19.367077] 8021q: adding VLAN 0 to HW filter on device bat0
[ 19.406417] device bat0 entered promiscuous mode
[ 19.411309] br-pub: port 1(bat0) entered forwarding state
[ 19.416772] br-pub: port 1(bat0) entered forwarding state
[ 19.422579] IPv6: ADDRCONF(NETDEV_CHANGE): br-pub: link becomes ready
[ 19.870508] batman_adv: bat0: bridge_loop_avoidance: Changing from: enabled to: disabled
[ 20.359133] batman_adv: bat0: No IGMP Querier present - multicast optimizations disabled
[ 20.367269] batman_adv: bat0: No MLD Querier present - multicast optimizations disabled
[ 21.412169] br-pub: port 1(bat0) entered forwarding state
[ 21.549966] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
[ 21.563679] device wlan0 entered promiscuous mode
[ 21.591315] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
[ 21.597879] br-pub: port 2(wlan0) entered forwarding state
[ 21.603541] br-pub: port 2(wlan0) entered forwarding state
[ 21.784924] IPv6: ADDRCONF(NETDEV_UP): mesh0: link is not ready
[ 21.912131] IPv6: ADDRCONF(NETDEV_CHANGE): mesh0: link becomes ready
[ 22.268273] batman_adv: bat0: Adding interface: mesh0
[ 22.273432] batman_adv: bat0: Interface activated: mesh0
[ 23.599046] br-pub: port 2(wlan0) entered forwarding state
[ 29.369162] batman_adv: bat0: IGMP Querier appeared
[ 29.374093] batman_adv: bat0: MLD Querier appeared
[ 34.068975] ------------[ cut here ]------------
[ 34.073700] WARNING: CPU: 0 PID: 0 at net/sched/sch_generic.c:306 dev_watchdog+0x1dc/0x260()
[ 34.082197] NETDEV WATCHDOG: eth0 (ag71xx): transmit queue 0 timed out
[ 34.088754] Modules linked in: ath9k ath9k_common mac80211 ath9k_hw ath batman_adv libcrc32c cfg80211 compat ohci_platform ohci_hcd ehci_platform ehci_hcd gpio_button_hotplug usbcore nls_base usb_common crc16
cryptomgr aead crypto_null crc32c_generic crypto_hash
[ 34.112252] CPU: 0 PID: 0 Comm: swapper Not tainted 4.4.32 #0
[ 34.118013] Stack : 803c8fc4 00000000 00000001 80420000 80413038 80412cc3 803aa67c 00000000
[ 34.118013] 8048379c 8041135c 00000200 00100000 0000000a 800a71a8 803afce8 80410000
[ 34.118013] 00000003 8041135c 803ae0f4 8040dc2c 0000000a 800a5124 00000006 00000000
[ 34.118013] 00000000 801f3100 00000000 00000000 00000000 00000000 00000000 00000000
[ 34.118013] 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000
[ 34.118013] ...
[ 34.153969] Call Trace:
[ 34.156440] [<80071af0>] show_stack+0x50/0x84
[ 34.160843] [<80081870>] warn_slowpath_common+0xa0/0xd0
[ 34.166096] [<800818cc>] warn_slowpath_fmt+0x2c/0x38
[ 34.171111] [<80290970>] dev_watchdog+0x1dc/0x260
[ 34.175854] [<800b0460>] call_timer_fn.isra.5+0x24/0x80
[ 34.181125] [<800b06e4>] run_timer_softirq+0x1b4/0x1fc
[ 34.186296] [<80083dec>] __do_softirq+0x250/0x298
[ 34.191059] [<8006a5d0>] plat_irq_dispatch+0xd4/0x10c
[ 34.196134] [<80060830>] ret_from_irq+0x0/0x4
[ 34.200526] [<80060a80>] __r4k_wait+0x20/0x40
[ 34.204906] [<800a2304>] cpu_startup_entry+0x9c/0xe8
[ 34.209934] [<80436bd4>] start_kernel+0x470/0x490
[ 34.214656]
[ 34.216159] ---[ end trace ef06a4b3ec78272a ]---
[ 34.220810] eth0: tx timeout
[ 37.565193] random: nonblocking pool is initialized
[ 44.068999] eth0: tx timeout
[ 54.069064] eth0: tx timeout
[ 64.068993] eth0: tx timeout
[ 74.069871] eth0: tx timeout
[ 82.660973] batman_adv: bat0: MLD Querier disappeared - multicast optimizations disabled
[ 84.070901] eth0: tx timeout
[ 92.701961] batman_adv: bat0: MLD Querier appeared
[ 94.071717] eth0: tx timeout
[ 104.072355] eth0: tx timeout
[ 114.072669] eth0: tx timeout
[...]

When I do an /etc/init.d/network restart, the interface recovers to normal function, and I get this in dmesg:

[ 1296.763793] br-pub: port 2(wlan0) entered disabled state
[ 1296.769232] br-pub: port 1(bat0) entered disabled state
[ 1296.808305] device bat0 left promiscuous mode
[ 1296.812986] br-pub: port 1(bat0) entered disabled state
[ 1296.862085] IPv6: ADDRCONF(NETDEV_UP): bat0: link is not ready
[ 1296.879239] device wlan0 left promiscuous mode
[ 1296.883945] br-pub: port 2(wlan0) entered disabled state
[ 1296.904196] batman_adv: bat0: Interface deactivated: mesh0
[ 1296.909752] batman_adv: bat0: Removing interface: mesh0
[ 1296.963462] batman_adv: bat0: Interface deactivated: eth0
[ 1296.993492] eth0: link down
[ 1296.998705] batman_adv: bat0: Removing interface: eth0
[ 1301.629484] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[ 1301.649941] IPv6: ADDRCONF(NETDEV_UP): br-pub: link is not ready
[ 1301.985100] eth0: link up (100Mbps/Full duplex)
[ 1301.989698] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[ 1302.191373] batman_adv: bat0: Adding interface: eth0
[ 1302.196453] batman_adv: bat0: The MTU of interface eth0 is too small (1500) to handle the transport of batman-adv packets. Packets going over this interface will be fragmented on layer2 which could impact the
performance. Setting the MTU to 1532 would solve the problem.
[ 1302.220488] batman_adv: bat0: Interface activated: eth0
[ 1302.228092] 8021q: adding VLAN 0 to HW filter on device bat0
[ 1302.275944] device bat0 entered promiscuous mode
[ 1302.280747] br-pub: port 1(bat0) entered forwarding state
[ 1302.286292] br-pub: port 1(bat0) entered forwarding state
[ 1302.292106] IPv6: ADDRCONF(NETDEV_CHANGE): br-pub: link becomes ready
[ 1302.590333] batman_adv: bat0: bridge_loop_avoidance: Changing from: enabled to: disabled
[ 1303.213417] batman_adv: bat0: No IGMP Querier present - multicast optimizations disabled
[ 1303.221556] batman_adv: bat0: No MLD Querier present - multicast optimizations disabled
[ 1304.283452] br-pub: port 1(bat0) entered forwarding state
[ 1304.672382] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
[ 1304.782643] device wlan0 entered promiscuous mode
[ 1304.827845] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
[ 1304.834479] br-pub: port 2(wlan0) entered forwarding state
[ 1304.840053] br-pub: port 2(wlan0) entered forwarding state
[ 1305.112607] IPv6: ADDRCONF(NETDEV_UP): mesh0: link is not ready
[ 1305.190600] IPv6: ADDRCONF(NETDEV_CHANGE): mesh0: link becomes ready
[ 1305.692918] batman_adv: bat0: Adding interface: mesh0
[ 1305.698080] batman_adv: bat0: Interface activated: mesh0
[ 1306.833410] br-pub: port 2(wlan0) entered forwarding state
[ 1312.303688] batman_adv: bat0: IGMP Querier appeared
[ 1312.308629] batman_adv: bat0: MLD Querier appeared

If I disconnect the other end of the ethernet cable so that there is no link peer, I do not see the problem (see below):

[ 0.000000] Linux version 4.4.32 (openwrt@hawg) (gcc version 5.4.0 (LEDE GCC 5.4.0 r1439) ) #0 Mon Nov 21 07:14:51 2016 [ 0.000000] MyLoader: sysp=00000000, boardp=00000000, parts=ffffffff [ 0.000000] bootconsole [early0] enabled [ 0.000000] CPU0 revision is: 00019374 (MIPS 24Kc) [ 0.000000] SoC: Atheros AR7240 rev 2 [ 0.000000] Determined physical RAM map: [ 0.000000] memory: 02000000 @ 00000000 (usable) [ 0.000000] Initrd not found or empty - disabling initrd [ 0.000000] No valid device tree found, continuing without [ 0.000000] Zone ranges: [ 0.000000] Normal [mem 0x0000000000000000-0x0000000001ffffff] [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000000000-0x0000000001ffffff] [ 0.000000] Initmem setup node 0 [mem 0x0000000000000000-0x0000000001ffffff] [ 0.000000] On node 0 totalpages: 8192 [ 0.000000] free_area_init_node: node 0, pgdat 80412320, node_mem_map 81000000 [ 0.000000] Normal zone: 64 pages used for memmap [ 0.000000] Normal zone: 0 pages reserved [ 0.000000] Normal zone: 8192 pages, LIFO batch:0 [ 0.000000] Primary instruction cache 64kB, 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: 8128 [ 0.000000] Kernel command line: board=UBNT-BM mtdparts=spi0.0:256k(u-boot)ro,64k(u-boot-env)ro,7552k(firmware),256k(cfg)ro,64k(EEPROM)ro console=ttyS0,115200 rootfstype=squashfs,jffs2 noinitrd [ 0.000000] PID hash table entries: 128 (order: -3, 512 bytes) [ 0.000000] Dentry cache hash table entries: 4096 (order: 2, 16384 bytes) [ 0.000000] Inode-cache hash table entries: 2048 (order: 1, 8192 bytes) [ 0.000000] Writing ErrCtl register=00000000 [ 0.000000] Readback ErrCtl register=00000000 [ 0.000000] Memory: 27616K/32768K available (2990K kernel code, 174K rwdata, 756K rodata, 296K init, 198K bss, 5152K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=32, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 [ 0.000000] NR_IRQS:51 [ 0.000000] Clocks: CPU:390.000MHz, DDR:390.000MHz, AHB:195.000MHz, Ref:40.000MHz [ 0.000000] clocksource: MIPS: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 9801335621 ns [ 0.000013] sched_clock: 32 bits at 195MHz, resolution 5ns, wraps every 11012737021ns [ 0.007859] Calibrating delay loop... 259.27 BogoMIPS (lpj=1296384) [ 0.080537] pid_max: default: 32768 minimum: 301 [ 0.085319] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes) [ 0.091915] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes) [ 0.102743] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns [ 0.113517] NET: Registered protocol family 16 [ 0.120061] MIPS: machine is Ubiquiti Bullet M [ 0.126721] registering PCI controller with io_map_base unset [ 0.357179] PCI host bridge to bus 0000:00 [ 0.361281] pci_bus 0000:00: root bus resource [mem 0x10000000-0x13ffffff] [ 0.368182] pci_bus 0000:00: root bus resource [io 0x0000] [ 0.373728] pci_bus 0000:00: root bus resource [??? 0x00000000 flags 0x0] [ 0.380495] pci_bus 0000:00: No busn resource found for root bus, will use [bus 00-ff] [ 0.388431] pci 0000:00:00.0: [168c:002a] type 00 class 0x028000 [ 0.388474] pci 0000:00:00.0: fixup device configuration [ 0.395026] pci 0000:00:00.0: reg 0x10: [mem 0x00000000-0x0000ffff 64bit] [ 0.395163] pci 0000:00:00.0: supports D1 [ 0.395187] pci 0000:00:00.0: PME# supported from D0 D1 D3hot [ 0.395530] pci_bus 0000:00: busn_res: [bus 00-ff] end is updated to 00 [ 0.395581] pci 0000:00:00.0: BAR 0: assigned [mem 0x10000000-0x1000ffff 64bit] [ 0.402872] pci 0000:00:00.0: using irq 40 for pin 1 [ 0.408968] clocksource: Switched to clocksource MIPS [ 0.415854] NET: Registered protocol family 2 [ 0.421444] TCP established hash table entries: 1024 (order: 0, 4096 bytes) [ 0.428402] TCP bind hash table entries: 1024 (order: 0, 4096 bytes) [ 0.434805] TCP: Hash tables configured (established 1024 bind 1024) [ 0.441299] UDP hash table entries: 256 (order: 0, 4096 bytes) [ 0.447134] UDP-Lite hash table entries: 256 (order: 0, 4096 bytes) [ 0.453795] NET: Registered protocol family 1 [ 0.458229] PCI: CLS 0 bytes, default 32 [ 0.464231] futex hash table entries: 256 (order: -1, 3072 bytes) [ 0.470521] Crashlog allocated RAM at address 0x1f00000 [ 0.495175] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ 0.501058] jffs2: version 2.2 (NAND) (SUMMARY) (LZMA) (RTIME) (CMODE_PRIORITY) (c) 2001-2006 Red Hat, Inc. [ 0.514341] io scheduler noop registered [ 0.518261] io scheduler deadline registered (default) [ 0.523733] Serial: 8250/16550 driver, 1 ports, IRQ sharing disabled [ 0.530718] console [ttyS0] disabled [ 0.554351] serial8250.0: ttyS0 at MMIO 0x18020000 (irq = 11, base_baud = 12187500) is a 16550A [ 0.563030] console [ttyS0] enabled [ 0.570040] bootconsole [early0] disabled [ 0.582496] m25p80 spi0.0: found mx25l6405d, expected m25p80 [ 0.588212] m25p80 spi0.0: mx25l6405d (8192 Kbytes) [ 0.593216] 5 cmdlinepart partitions found on MTD device spi0.0 [ 0.599171] Creating 5 MTD partitions on "spi0.0": [ 0.603989] 0x000000000000-0x000000040000 : "u-boot" [ 0.611984] 0x000000040000-0x000000050000 : "u-boot-env" [ 0.619662] 0x000000050000-0x0000007b0000 : "firmware" [ 0.638852] 2 uimage-fw partitions found on MTD device firmware [ 0.644868] 0x000000050000-0x0000001a0000 : "kernel" [ 0.651750] 0x0000001a0000-0x0000007b0000 : "rootfs" [ 0.658926] mtd: device 4 (rootfs) set to be root filesystem [ 0.664753] 1 squashfs-split partitions found on MTD device rootfs [ 0.671004] 0x000000550000-0x0000007b0000 : "rootfs_data" [ 0.678725] 0x0000007b0000-0x0000007f0000 : "cfg" [ 0.685800] 0x0000007f0000-0x000000800000 : "EEPROM" [ 0.713752] libphy: ag71xx_mdio: probed [ 1.302703] ag71xx ag71xx.0: connected to PHY at ag71xx-mdio.0:04 [uid=004dd041, driver=Generic PHY] [ 1.312917] eth0: Atheros AG71xx at 0xb9000000, irq 4, mode:MII [ 1.322177] NET: Registered protocol family 10 [ 1.332146] NET: Registered protocol family 17 [ 1.336720] bridge: automatic filtering via arp/ip/ip6tables has been deprecated. Update your scripts to load br_netfilter if you need this. [ 1.349611] 8021q: 802.1Q VLAN Support v1.8 [ 1.362390] VFS: Mounted root (squashfs filesystem) readonly on device 31:4. [ 1.372040] Freeing unused kernel memory: 296K (80436000 - 80480000) [ 2.887726] init: Console is alive [ 2.891520] init: - watchdog - [ 4.278086] usbcore: registered new interface driver usbfs [ 4.283799] usbcore: registered new interface driver hub [ 4.289318] usbcore: registered new device driver usb [ 4.301475] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver [ 4.310215] ehci-platform: EHCI generic platform driver [ 4.319363] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver [ 4.327317] ohci-platform: OHCI generic platform driver [ 4.336163] init: - preinit - [ 5.148612] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready [ 5.181619] random: procd: uninitialized urandom read (4 bytes read, 8 bits of entropy available) [ 8.484735] jffs2: notice: (361) jffs2_build_xattr_subsystem: complete building xattr subsystem, 0 of xdatum (0 unchecked, 0 orphan) and 0 of xref (0 dead, 0 orphan) found. [ 8.502585] mount_root: switching to jffs2 overlay [ 8.518273] urandom-seed: Seeding with /etc/urandom.seed [ 8.810840] procd: - early - [ 8.813863] procd: - watchdog - [ 9.487850] procd: - ubus - [ 9.541721] random: ubusd: uninitialized urandom read (4 bytes read, 15 bits of entropy available) [ 9.551409] random: ubusd: uninitialized urandom read (4 bytes read, 15 bits of entropy available) [ 9.560553] random: ubusd: uninitialized urandom read (4 bytes read, 15 bits of entropy available) [ 9.570163] random: ubusd: uninitialized urandom read (4 bytes read, 15 bits of entropy available) [ 9.579297] random: ubusd: uninitialized urandom read (4 bytes read, 15 bits of entropy available) [ 9.589333] random: ubusd: uninitialized urandom read (4 bytes read, 15 bits of entropy available) [ 9.598611] random: ubusd: uninitialized urandom read (4 bytes read, 15 bits of entropy available) [ 9.608223] procd: - init - [ 10.064115] Loading modules backported from Linux version wt-2016-10-03-1-g6fcb1a6 [ 10.071796] Backport generated by backports.git backports-20160324-9-g0e38f5c [ 10.122372] batman_adv: B.A.T.M.A.N. advanced 2016.4 (compatibility version 15) loaded [ 10.205329] PCI: Enabling device 0000:00:00.0 (0000 -> 0002) [ 10.216362] ath: phy0: Ignoring endianness difference in EEPROM magic bytes. [ 10.225034] ath: EEPROM regdomain: 0x0 [ 10.225051] ath: EEPROM indicates default country code should be used [ 10.225065] ath: doing EEPROM country->regdmn map search [ 10.225093] ath: country maps to regdmn code: 0x3a [ 10.225109] ath: Country alpha2 being used: US [ 10.225122] ath: Regpair used: 0x3a [ 10.240049] ieee80211 phy0: Selected rate control algorithm 'minstrel_ht' [ 10.248689] ieee80211 phy0: Atheros AR9280 Rev:2 mem=0xb0000000, irq=40 [ 11.861887] random: jshn: uninitialized urandom read (4 bytes read, 19 bits of entropy available) [ 11.993063] random: ubusd: uninitialized urandom read (4 bytes read, 19 bits of entropy available) [ 18.833441] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready [ 18.855566] IPv6: ADDRCONF(NETDEV_UP): br-pub: link is not ready [ 21.215610] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [ 21.255512] device wlan0 entered promiscuous mode [ 21.286637] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [ 21.293301] br-pub: port 1(wlan0) entered forwarding state [ 21.298864] br-pub: port 1(wlan0) entered forwarding state [ 21.335689] IPv6: ADDRCONF(NETDEV_CHANGE): br-pub: link becomes ready [ 21.541225] IPv6: ADDRCONF(NETDEV_UP): mesh0: link is not ready [ 21.594616] IPv6: ADDRCONF(NETDEV_CHANGE): mesh0: link becomes ready [ 22.284927] batman_adv: bat0: Adding interface: mesh0 [ 22.290148] batman_adv: bat0: Interface activated: mesh0 [ 22.297750] 8021q: adding VLAN 0 to HW filter on device bat0 [ 22.362868] device bat0 entered promiscuous mode [ 22.367627] br-pub: port 2(bat0) entered forwarding state [ 22.373200] br-pub: port 2(bat0) entered forwarding state [ 22.718089] batman_adv: bat0: bridge_loop_avoidance: Changing from: enabled to: disabled [ 23.289035] br-pub: port 1(wlan0) entered forwarding state [ 23.309325] batman_adv: bat0: No IGMP Querier present - multicast optimizations disabled [ 23.317459] batman_adv: bat0: No MLD Querier present - multicast optimizations disabled [ 24.369054] br-pub: port 2(bat0) entered forwarding state [ 29.389161] batman_adv: bat0: IGMP Querier appeared [ 38.069058] random: nonblocking pool is initialized [ 44.920666] eth0: link up (100Mbps/Full duplex) [ 44.925732] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 45.001214] batman_adv: bat0: Adding interface: eth0 [ 45.006233] batman_adv: bat0: The MTU of interface eth0 is too small (1500) to handle the transport of batman-adv packets. Packets going over this interface will be fragmented on layer2 which could impact the performance. Setting the MTU to 1532 would solve the problem. [ 45.030291] batman_adv: bat0: Interface activated: eth0 [ 50.459193] batman_adv: bat0: MLD Querier appeared [ 67.509156] batman_adv: bat0: MLD Querier disappeared - multicast optimizations disabled [ 77.549128] batman_adv: bat0: MLD Querier appeared

My LEDE diffconfig looks like this:

CONFIG_TARGET_ar71xx=y CONFIG_TARGET_ar71xx_generic=y CONFIG_TARGET_ar71xx_generic_DEVICE_ubnt-bullet-m=y CONFIG_DEVEL=y CONFIG_BUSYBOX_CUSTOM=y CONFIG_ALFRED_NEEDS_lua=y CONFIG_BUILD_LOG=y CONFIG_BUSYBOX_CONFIG_MESG=y CONFIG_BUSYBOX_CONFIG_PKILL=y CONFIG_BUSYBOX_CONFIG_RDATE=y # CONFIG_BUSYBOX_CONFIG_SHA256SUM is not set CONFIG_KMOD_BATMAN_ADV_BATMAN_V=y CONFIG_KMOD_BATMAN_ADV_BLA=y CONFIG_KMOD_BATMAN_ADV_DAT=y CONFIG_KMOD_BATMAN_ADV_DEBUGFS=y CONFIG_KMOD_BATMAN_ADV_MCAST=y CONFIG_LIBCURL_COOKIES=y CONFIG_LIBCURL_FILE=y CONFIG_LIBCURL_FTP=y CONFIG_LIBCURL_HTTP=y CONFIG_LIBCURL_NO_SMB="!" CONFIG_LIBCURL_POLARSSL=y CONFIG_LIBCURL_PROXY=y CONFIG_OPENSSL_ENGINE_CRYPTO=y CONFIG_OPENSSL_WITH_DEPRECATED=y CONFIG_OPENSSL_WITH_EC=y CONFIG_OPENSSL_WITH_NPN=y CONFIG_OPENSSL_WITH_PSK=y CONFIG_OPENSSL_WITH_SRP=y CONFIG_PACKAGE_ALFRED_BATHOSTS=y CONFIG_PACKAGE_ALFRED_VIS=y CONFIG_PACKAGE_alfred=y CONFIG_PACKAGE_batctl=y CONFIG_PACKAGE_bridge=y CONFIG_PACKAGE_curl=y CONFIG_PACKAGE_diffutils=y # CONFIG_PACKAGE_dnsmasq is not set # CONFIG_PACKAGE_firewall is not set CONFIG_PACKAGE_horst=y CONFIG_PACKAGE_iftop=y # CONFIG_PACKAGE_ip6tables is not set CONFIG_PACKAGE_iperf3=y # CONFIG_PACKAGE_iptables is not set CONFIG_PACKAGE_kmod-batman-adv=y CONFIG_PACKAGE_kmod-bridge=y CONFIG_PACKAGE_kmod-crypto-aead=y CONFIG_PACKAGE_kmod-crypto-crc32c=y CONFIG_PACKAGE_kmod-crypto-hash=y CONFIG_PACKAGE_kmod-crypto-manager=y CONFIG_PACKAGE_kmod-crypto-null=y CONFIG_PACKAGE_kmod-crypto-pcompress=y # CONFIG_PACKAGE_kmod-ip6tables is not set # CONFIG_PACKAGE_kmod-ipt-conntrack is not set # CONFIG_PACKAGE_kmod-ipt-core is not set # CONFIG_PACKAGE_kmod-ipt-nat is not set # CONFIG_PACKAGE_kmod-lib-crc-ccitt is not set CONFIG_PACKAGE_kmod-lib-crc16=y CONFIG_PACKAGE_kmod-lib-crc32c=y CONFIG_PACKAGE_kmod-llc=y # CONFIG_PACKAGE_kmod-nf-conntrack is not set # CONFIG_PACKAGE_kmod-nf-conntrack6 is not set # CONFIG_PACKAGE_kmod-nf-ipt is not set # CONFIG_PACKAGE_kmod-nf-ipt6 is not set # CONFIG_PACKAGE_kmod-nf-nat is not set # CONFIG_PACKAGE_kmod-ppp is not set CONFIG_PACKAGE_kmod-stp=y CONFIG_PACKAGE_libcurl=y # CONFIG_PACKAGE_libip4tc is not set # CONFIG_PACKAGE_libip6tc is not set CONFIG_PACKAGE_liblua=y CONFIG_PACKAGE_libncursesw=y CONFIG_PACKAGE_libnetsnmp=y CONFIG_PACKAGE_libopenssl=y CONFIG_PACKAGE_libpcap=y CONFIG_PACKAGE_libpcre=y CONFIG_PACKAGE_libpolarssl=y CONFIG_PACKAGE_libpopt=y CONFIG_PACKAGE_libpthread=y CONFIG_PACKAGE_librt=y # CONFIG_PACKAGE_libxtables is not set CONFIG_PACKAGE_lua=y # CONFIG_PACKAGE_odhcp6c is not set # CONFIG_PACKAGE_odhcpd is not set # CONFIG_PACKAGE_ppp is not set CONFIG_PACKAGE_procps-ng=y CONFIG_PACKAGE_procps-ng-free=y CONFIG_PACKAGE_procps-ng-kill=y CONFIG_PACKAGE_procps-ng-pgrep=y CONFIG_PACKAGE_procps-ng-pkill=y CONFIG_PACKAGE_procps-ng-pmap=y CONFIG_PACKAGE_procps-ng-ps=y CONFIG_PACKAGE_procps-ng-pwdx=y CONFIG_PACKAGE_procps-ng-skill=y CONFIG_PACKAGE_procps-ng-slabtop=y CONFIG_PACKAGE_procps-ng-snice=y CONFIG_PACKAGE_procps-ng-tload=y CONFIG_PACKAGE_procps-ng-top=y CONFIG_PACKAGE_procps-ng-uptime=y CONFIG_PACKAGE_procps-ng-vmstat=y CONFIG_PACKAGE_procps-ng-w=y CONFIG_PACKAGE_procps-ng-watch=y CONFIG_PACKAGE_ptp-utils=y CONFIG_PACKAGE_rsync=y CONFIG_PACKAGE_snmpd=y CONFIG_PACKAGE_tcpdump=y CONFIG_PACKAGE_terminfo=y CONFIG_PACKAGE_wget=y CONFIG_PACKAGE_wireless-tools=y CONFIG_PACKAGE_zlib=y CONFIG_RSYNC_zlib=y

My uci show looks like this (system and wireless elided):

alfred.alfred=alfred
alfred.alfred.mode='master'
alfred.alfred.batmanif='bat0'
alfred.alfred.start_vis='1'
alfred.alfred.run_facters='1'
alfred.alfred.interface='br-pub'
alfred.alfred.disabled='0'
batman-adv.bat0=mesh
batman-adv.bat0.bridge_loop_avoidance='0'
dropbear.@dropbear[0]=dropbear
dropbear.@dropbear[0].PasswordAuth='on'
dropbear.@dropbear[0].RootPasswordAuth='on'
dropbear.@dropbear[0].Port='22'
network.loopback=interface
network.loopback.ifname='lo'
network.loopback.proto='static'
network.loopback.ipaddr='127.0.0.1'
network.loopback.netmask='255.0.0.0'
network.pub=interface
network.pub.type='bridge'
network.pub.proto='static'
network.pub.ip6assign='60'
network.pub.ifname='bat0'
network.pub.ipaddr='10.11.x.y'
network.pub.netmask='255.255.252.0'
network.pub.gateway='10.11.x.1'
network.pub.dns='10.11.x.1'
network.mesh=interface
network.mesh.mtu='1532'
network.mesh.proto='batadv'
network.mesh.mesh='bat0'
network.meshwire=interface
network.meshwire.proto='batadv'
network.meshwire.mesh='bat0'
network.meshwire.ifname='eth0'

@openwrt-bot
Copy link
Author

FreifunkUFO:

its related to https://dev.openwrt.org/ticket/19085
i also still have this problem. https://plan.leipzig.freifunk.net/issues/159 (f.i. m5loco_xw)
i heard that at 33c3 there were some changes done. but still have that problem, no only on xw-hardware.

you could try to change (ethernet-speed AND change) auto-negiotation, that might help a bit. but i didnt document that behaviour yet.

@openwrt-bot
Copy link
Author

FreifunkUFO:

are there any news about that problem?

see also http://gerrit.aredn.org/#/c/57

@openwrt-bot
Copy link
Author

russell:

I just saw this again on 5572-g4a4d957d1a. It seems to matter what it is plugged into or maybe it just isn't deterministic, since the same configuration on the same kind of hardware nearby (flashed at about the same time with the same build, except for ipaddr) came up okay.

All I'm sure of is that there were many "eth0: tx timeout" messages.

@openwrt-bot
Copy link
Author

russell:

Just reconfirmed this issue still exists on r6655-3612d90351. It does matter what is plugged in at the end of the ethernet cable. If it is a 10/100 switch, no problems. If it is a gigabit ethernet, I get the problem:

# dmesg | grep eth0
[ 1.401954] eth0: Atheros AG71xx at 0xb9000000, irq 4, mode:MII
[ 4.674281] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[ 7.789596] eth0: link up (10Mbps/Half duplex)
[ 7.794104] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[ 8.227655] eth0: link down
[ 19.668418] br-pub: port 1(eth0) entered blocking state
[ 19.673682] br-pub: port 1(eth0) entered disabled state
[ 19.679497] device eth0 entered promiscuous mode
[ 19.765653] eth0: link up (1000Mbps/Full duplex)
[ 19.799292] br-pub: port 1(eth0) entered blocking state
[ 19.804555] br-pub: port 1(eth0) entered forwarding state
[ 36.120995] NETDEV WATCHDOG: eth0 (ag71xx): transmit queue 0 timed out
[ 36.266008] eth0: tx timeout
[ 46.108024] eth0: tx timeout

@openwrt-bot
Copy link
Author

russell:

This patch from neoraider fixed it for me:

diff --git a/target/linux/ar71xx/files/arch/mips/ath79/mach-ubnt-xm.c b/target/linux/ar71xx/files/arch/mips/ath79/mach-ubnt-xm.c index 8afb3ad054b8..8dc0be41a3a4 100644 --- a/target/linux/ar71xx/files/arch/mips/ath79/mach-ubnt-xm.c +++ b/target/linux/ar71xx/files/arch/mips/ath79/mach-ubnt-xm.c @@ -97,7 +97,9 @@ static void __init ubnt_xm_init(void) ap91_pci_init(eeprom, NULL);
ath79_register_mdio(0, ~UBNT_M_WAN_PHYMASK);
  • ath79_eth0_data.speed = SPEED_100;
    ath79_init_mac(ath79_eth0_data.mac_addr, mac1, 0);
  • ath79_eth1_data.speed = SPEED_100;
    ath79_init_mac(ath79_eth1_data.mac_addr, mac2, 0);
    ath79_register_eth(0);
    }

@openwrt-bot
Copy link
Author

sumpfralle:

I am just installed b1f5dd3 on an Ubiquiti Nanostation M5 HP (XM).

Here I see the following output during boot:

[ 1.631130] eth0: Atheros AG71xx at 0xb9000000, irq 4, mode:MII
[ 2.312783] eth1: Atheros AG71xx at 0xba000000, irq 5, mode:GMII
[ 5.006951] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[ 7.070796] eth0: link up (100Mbps/Full duplex)
[ 7.075396] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[ 25.719656] eth0: link down
[ 74.380702] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[ 74.406151] br-on_eth_0: port 1(eth0.10) entered blocking state
[ 74.412190] br-on_eth_0: port 1(eth0.10) entered disabled state
[ 74.418692] device eth0.10 entered promiscuous mode
[ 74.423657] device eth0 entered promiscuous mode
[ 74.585241] br-on_eth_0: port 2(eth1) entered blocking state
[ 74.591012] br-on_eth_0: port 2(eth1) entered disabled state
[ 74.597241] device eth1 entered promiscuous mode
[ 74.602071] br-on_eth_0: port 2(eth1) entered blocking state
[ 74.607762] br-on_eth_0: port 2(eth1) entered forwarding state
[ 75.409320] br-on_eth_0: port 2(eth1) entered disabled state
[ 76.260402] eth1: link up (1000Mbps/Full duplex)
[ 76.265110] br-on_eth_0: port 2(eth1) entered blocking state
[ 76.270833] br-on_eth_0: port 2(eth1) entered forwarding state
[ 76.430873] eth0: link up (100Mbps/Full duplex)
[ 76.435474] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[ 76.529338] br-on_eth_0: port 1(eth0.10) entered blocking state
[ 76.535300] br-on_eth_0: port 1(eth0.10) entered forwarding state

The line [ 76.260402] eth1: link up (1000Mbps/Full duplex) looks like the second port is still recognized as 1000 MBit/s?

btw.: "ethtool" shows 1000 MBit/s even for the first interface, while there is no output for eth1:

root@AP-1-110:# ethtool eth0
Settings for eth0:
Supported ports: [ TP MII ]
Supported link modes: 10baseT/Half 10baseT/Full
100baseT/Half 100baseT/Full
1000baseT/Full
Supported pause frame use: No
Supports auto-negotiation: Yes
Advertised link modes: 10baseT/Half 10baseT/Full
100baseT/Half 100baseT/Full
1000baseT/Full
[..]
root@AP-1-110:
# ethtool eth1
Settings for eth1:
Cannot get device settings: No such device
Current message level: 0x000000ff (255)
drv probe link timer ifdown ifup rx_err tx_err
Link detected: yes

But maybe I am mixing up different topics together.

Please correct me, if I misunderstand something. Thank you!

@openwrt-bot
Copy link
Author

NeoRaider:

I also got a report that the bug is not fixed after all. Unfortunately, I do not have test hardware to further investigate the issue.

@openwrt-bot
Copy link
Author

sumpfralle:

Maybe you have an idea (or an untested patch), that I could try?
Or do you have a suggestion, where I could take a look at the code?

I could also make a device available (via ssh) for testing, if this would be helpful.

@openwrt-bot
Copy link
Author

russell:

For now, I'm using the following work around. In /etc/rc.local (above exit 0), I am adding:

sleep 10
eth0speed=$(cat /sys/class/net/eth0/speed)
logger -t kludge "eth0 link speed $eth0speed"
if [ "$eth0speed" -gt 100 ]
then
logger -t kludge "detected eth0 link problem, restarting network"
/etc/init.d/network restart
fi

@openwrt-bot
Copy link
Author

@openwrt-bot
Copy link
Author

NeoRaider:

As I already mentioned in an earlier comment, my "fix" did not have any effect on this issue.

@openwrt-bot
Copy link
Author

russell:

This problem is still present on 9680-g0304e76cd1 (tested on ar71xx on Bullet M5 AR7240 rev 2). Currently doing some automated testing using a Ubiquiti ER-X to power cycle its PoE port. Seeing about 1/4 of the time, eth0 comes up with 1000Mbps at about 22 seconds into the boot. The other 3/4 of the time, eth0 comes up at 100Mbps.

@openwrt-bot
Copy link
Author

russell:

Current statistics are 939 failures (comes up at 1000Mbps) out of 3295 boots (a failure rate of 0.285). Note that the interface first comes up at 100Mbps at 7.x seconds into the boot, but later is downed and then brought up again. Success looks like this:

[ 1.403103] eth0: Atheros AG71xx at 0xb9000000, irq 4, mode:MII [ 5.245908] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready [ 7.310830] eth0: link up (100Mbps/Full duplex) [ 7.315426] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 8.871292] eth0: link down [ 22.293177] br-pub: port 1(eth0) entered blocking state [ 22.298438] br-pub: port 1(eth0) entered disabled state [ 22.304183] device eth0 entered promiscuous mode [ 24.430928] eth0: link up (100Mbps/Full duplex) [ 24.435544] br-pub: port 1(eth0) entered blocking state [ 24.440850] br-pub: port 1(eth0) entered forwarding state

Failure looks like this:

[ 1.403123] eth0: Atheros AG71xx at 0xb9000000, irq 4, mode:MII [ 5.241516] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready [ 7.310845] eth0: link up (100Mbps/Full duplex) [ 7.315443] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 8.878286] eth0: link down [ 22.333057] br-pub: port 1(eth0) entered blocking state [ 22.338319] br-pub: port 1(eth0) entered disabled state [ 22.344069] device eth0 entered promiscuous mode [ 22.428715] eth0: link up (1000Mbps/Full duplex) [ 22.483442] br-pub: port 1(eth0) entered blocking state [ 22.488708] br-pub: port 1(eth0) entered forwarding state

@openwrt-bot
Copy link
Author

russell:

Confirmed bug still present at version reboot-10753-gbcfd1d7685.

@openwrt-bot
Copy link
Author

russell:

I can trigger the bug at approximately the same probability (~1/4 of the time) running: ifconfig eth0 down ; sleep 1 ; ifconfig eth0 up

@openwrt-bot
Copy link
Author

russell:

Super kludge:

  • add an interface to /etc/config/network for eth0 (in my configuration, eth0 is part of a bridge, so it otherwise won't generate hotplug events):

config interface 'eth0'
option proto 'none'
option ifname 'eth0'

  • add a hotplug script to /etc/hotplug.d/iface:

[ ifup = "$ACTION" ] && {
[ "$INTERFACE" = "eth0" ] && {
eth0speed=$(cat /sys/class/net/eth0/speed)
logger -t kludge "eth0 link speed $eth0speed"
if [ "$eth0speed" -gt 100 ]; then
logger -t kludge "detected eth0 link problem, restarting eth0"
ifconfig eth0 down ; sleep 1 ; ifconfig eth0 up
fi
}
}

@openwrt-bot
Copy link
Author

gibsonlp:

Jumping very late to the party.

FWIW I am constantly reproducing this in XM hardware with multiple Bullet M5 units.

What I see:
OpenWRT 10:
Works fine

OpenWRT 15 :
link is sometimes at 1gbps (exactly as described here, roughly 1/4th of the time, I used a similar workaround method to the ones described here.

'OpenWRT 18 and up:
Link is constantly at 10mbps, couldn't find a way to force it to 100mbps (tried ethtool to no avail)

Is there any progress around this issue?

@openwrt-bot
Copy link
Author

russell:

Gil, there is support in ath79 now that, at least as of a week or so ago, did not have the speed flapping problem. Beware of which SoC is in your bullet, the ar7240 and ar7241 have different ethernet wiring and are incompatible, so pick the right one for your device. Check the top few lines of dmesg to find out which SoC you have.

@openwrt-bot
Copy link
Author

gibsonlp:

Thanks.
I cloned the latest git repo to give it a shot.

@openwrt-bot
Copy link
Author

gibsonlp:

Compiled and run successfully with the lates trunk, thanks!

@RussellSenior
Copy link
Contributor

This is fixed with the change to ath79. Please close.

@mkresin mkresin closed this as completed Apr 18, 2022
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
Projects
None yet
Development

No branches or pull requests

3 participants