victronenergy / venus

Victron Energy Unix/Linux OS
https://github.com/victronenergy/venus/wiki
577 stars 72 forks source link

kernel panic after inserting usb wifi #34

Closed mpvader closed 8 years ago

mpvader commented 8 years ago

besides the main issue, two others:

root@beaglebone:~# [12768.419617] usb 1-1: new high-speed USB device number 2 using musb-hdrc
[12768.575513] usb 1-1: New USB device found, idVendor=0586, idProduct=341e
[12768.582586] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[12768.590094] usb 1-1: Product: 802.11 n WLAN
[12768.594481] usb 1-1: Manufacturer: Ralink
[12768.598682] usb 1-1: SerialNumber: 1.0
[12768.736212] cfg80211: Calling CRDA to update world regulatory domain
[12768.877037] cfg80211: World regulatory domain updated:
[12768.882581] cfg80211:  DFS Master region: unset
[12768.887154] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time)
[12768.897410] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
[12768.905834] cfg80211:   (2457000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
[12768.914248] cfg80211:   (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm), (N/A)
[12768.922664] cfg80211:   (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A)
[12768.932622] cfg80211:   (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s)
[12768.942577] cfg80211:   (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A, 2000 mBm), (0 s)
[12768.951075] cfg80211:   (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A)
[12768.959481] cfg80211:   (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm), (N/A)
[12769.129587] usb 1-1: reset high-speed USB device number 2 using musb-hdrc
[12769.281856] ieee80211 phy0: rt2x00_set_rt: Info - RT chipset 3070, rev 0201 detected
[12769.309186] ieee80211 phy0: rt2x00_set_rf: Info - RF chipset 0005 detected
[12769.379835] usbcore: registered new interface driver rt2800usb
[12769.398813] ieee80211 phy0: rt2x00lib_request_firmware: Info - Loading firmware file 'rt2870.bin'
[12769.450057] ieee80211 phy0: rt2x00lib_request_firmware: Info - Firmware detected - version: 0.29
[12769.906083] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready

root@beaglebone:~#
root@beaglebone:~# ifconfig
eth0      Link encap:Ethernet  HWaddr EC:24:B8:9E:18:DF
          inet addr:192.168.51.62  Bcast:192.168.51.255  Mask:255.255.255.0
          inet6 addr: fe80::ee24:b8ff:fe9e:18df/64 Scope:Link
          UP BROADCAST RUNNING MULTICAST  MTU:1500  Metric:1
          RX packets:45951 errors:0 dropped:4 overruns:0 frame:0
          TX packets:5566 errors:0 dropped:0 overruns:0 carrier:0
          collisions:0 txqueuelen:1000
          RX bytes:12128812 (11.5 MiB)  TX bytes:1440693 (1.3 MiB)
          Interrupt:173

lo        Link encap:Local Loopback
          inet addr:127.0.0.1  Mask:255.0.0.0
          inet6 addr: ::1/128 Scope:Host
          UP LOOPBACK RUNNING  MTU:65536  Metric:1
          RX packets:1051 errors:0 dropped:0 overruns:0 frame:0
          TX packets:1051 errors:0 dropped:0 overruns:0 carrier:0
          collisions:0 txqueuelen:0
          RX bytes:777913 (759.6 KiB)  TX bytes:777913 (759.6 KiB)

wlan0     Link encap:Ethernet  HWaddr 10:7B:EF:C7:79:A4
          UP BROADCAST MULTICAST  MTU:1500  Metric:1
          RX packets:0 errors:0 dropped:0 overruns:0 frame:0
          TX packets:0 errors:0 dropped:0 overruns:0 carrier:0
          collisions:0 txqueuelen:1000
          RX bytes:0 (0.0 B)  TX bytes:0 (0.0 B)

root@beaglebone:~# ifconfig
eth0      Link encap:Ethernet  HWaddr EC:24:B8:9E:18:DF
          inet addr:192.168.51.62  Bcast:192.168.51.255  Mask:255.255.255.0
          inet6 addr: fe80::ee24:b8ff:fe9e:18df/64 Scope:Link
          UP BROADCAST RUNNING MULTICAST  MTU:1500  Metric:1
          RX packets:45954 errors:0 dropped:4 overruns:0 frame:0
          TX packets:5566 errors:0 dropped:0 overruns:0 carrier:0
          collisions:0 txqueuelen:1000
          RX bytes:12129239 (11.5 MiB)  TX bytes:1440693 (1.3 MiB)
          Interrupt:173

lo        Link encap:Local Loopback
          inet addr:127.0.0.1  Mask:255.0.0.0
          inet6 addr: ::1/128 Scope:Host
          UP LOOPBACK RUNNING  MTU:65536  Metric:1
          RX packets:1051 errors:0 dropped:0 overruns:0 frame:0
          TX packets:1051 errors:0 dropped:0 overruns:0 carrier:0
          collisions:0 txqueuelen:0
          RX bytes:777913 (759.6 KiB)  TX bytes:777913 (759.6 KiB)

wlan0     Link encap:Ethernet  HWaddr 10:7B:EF:C7:79:A4
          UP BROADCAST MULTICAST  MTU:1500  Metric:1
          RX packets:0 errors:0 dropped:0 overruns:0 frame:0
          TX packets:0 errors:0 dropped:0 overruns:0 carrier:0
          collisions:0 txqueuelen:1000
          RX bytes:0 (0.0 B)  TX bytes:0 (0.0 B)

root@beaglebone:~# [12784.879644] ieee80211 phy0: rt2x00usb_vendor_request: Error - Vendor Request 0x07 failed for offset 0x1004 with error -110
[12784.924488] usb 1-1: USB disconnect, device number 2
[12784.940217] ieee80211 phy0: rt2x00usb_vendor_request: Error - Vendor Request 0x06 failed for offset 0x1004 with error -19
[12785.087679] ieee80211 phy0: rt2800usb_tx_sta_fifo_read_completed: Warning - TX status read failed -108
[12785.097486] Unable to handle kernel NULL pointer dereference at virtual address 00000084
[12785.105970] pgd = c0004000
[12785.108805] [00000084] *pgd=00000000
[12785.112565] Internal error: Oops: 17 [#1] ARM
[12785.117133] Modules linked in: arc4 rt2800usb rt2x00usb rt2800lib rt2x00lib mac80211 cfg80211 rfkill ti_am335x_adc kfifo_buf industrialio ti_am335x_tsc ti_am335x_tscadc
[12785.132983] CPU: 0 PID: 3 Comm: ksoftirqd/0 Not tainted 4.1.15-venus #1
[12785.139917] Hardware name: Generic AM33XX (Flattened Device Tree)
[12785.146304] task: de08c040 ti: de096000 task.ti: de096000
[12785.151973] PC is at __lock_acquire+0x1e8/0x1da0
[12785.156814] LR is at 0x1
[12785.159467] pc : [<c0066c74>]    lr : [<00000001>]    psr: 20070093
[12785.159467] sp : de097d48  ip : de096000  fp : c070d974
[12785.171501] r10: c072eda4  r9 : de08c040  r8 : c06f1468
[12785.176976] r7 : c0eee934  r6 : 00000084  r5 : 00000000  r4 : 00000000
[12785.183818] r3 : c0d1db4c  r2 : 00000000  r1 : 00000000  r0 : 00000084
[12785.190661] Flags: nzCv  IRQs off  FIQs on  Mode SVC_32  ISA ARM  Segment kernel
[12785.198415] Control: 10c5387d  Table: 95098019  DAC: 00000015
[12785.204437] Process ksoftirqd/0 (pid: 3, stack limit = 0xde096210)
[12785.210915] Stack: (0xde097d48 to 0xde098000)
[12785.215483] 7d40:                   00000000 c02a644c 00000000 de097e1c 001fe050 00000000
[12785.224060] 7d60: 53425553 45545359 65693d4d 30386565 00313132 49564544 2b3d4543 65656569
[12785.232635] 7d80: 31323038 68703a31 de003079 de272da0 c0eee934 c06f1468 de08c040 00000000
[12785.241210] 7da0: 80070093 00000084 00000000 00000000 00000000 c072eda4 60070093 c006912c
[12785.249785] 7dc0: 00000001 00000080 00000000 bf18db9c 00000000 c0d6631c de08c040 00000000
[12785.258361] 7de0: c070d974 00000074 80070093 bf18db9c 000000b8 de272d90 de096000 00000000
[12785.266937] 7e00: 00000018 c04c1a18 00000001 00000000 bf18db9c c02a68b4 00000002 00000000
[12785.275513] 7e20: 00000074 bf18db9c 00000000 000000b8 de7f9300 bf1be9bc de7f9300 de764240
[12785.284089] 7e40: de272c00 00000000 de272d90 bf1beb64 de272d8c de272d90 dd165e40 bf1b7418
[12785.292665] 7e60: de764240 60070013 de272c00 c0301aec de272d8c de097e88 00000000 de272db0
[12785.301241] 7e80: de272d90 c0301c14 de097e88 de097e88 de272db8 00000000 c06ed3a0 00000000
[12785.309817] 7ea0: 00000100 c00362a8 c07315d8 00000006 00000240 c072eb10 00000100 c00358d4
[12785.318393] 7ec0: c06eff30 00000000 00000007 c06f04a0 c0731580 0000000a 00130cfd c06f29a0
[12785.326970] 7ee0: 04208040 00000000 de096000 de028800 de096000 00000000 00000001 c06ed3b4
[12785.335545] 7f00: 00000000 00000000 00000000 c0035b64 de028800 c0051edc 00000000 de0287c0
[12785.344120] 7f20: de028800 c0051dd4 00000000 c004eae4 00000001 00000001 00000000 de028800
[12785.352696] 7f40: 00000000 00000001 dead4ead ffffffff ffffffff c0731ad4 c0868ca4 00000000
[12785.361273] 7f60: c05ef984 de097f64 de097f64 00000000 00000001 dead4ead ffffffff ffffffff
[12785.369849] 7f80: c0731ad4 00000000 00000000 c05ef984 de097f90 de097f90 de097fac de0287c0
[12785.378425] 7fa0: c004ea08 00000000 00000000 c000f238 00000000 00000000 00000000 00000000
[12785.387000] 7fc0: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000
[12785.395575] 7fe0: 00000000 00000000 00000000 00000000 00000013 00000000 78093675 cf8e62e9
[12785.404160] [<c0066c74>] (__lock_acquire) from [<c006912c>] (lock_acquire+0xac/0x12c)
[12785.412383] [<c006912c>] (lock_acquire) from [<c04c1a18>] (_raw_spin_lock_irqsave+0x3c/0x50)
[12785.421281] [<c04c1a18>] (_raw_spin_lock_irqsave) from [<bf18db9c>] (rt2x00queue_get_entry+0x24/0x7c [rt2x00lib])
[12785.432071] [<bf18db9c>] (rt2x00queue_get_entry [rt2x00lib]) from [<bf1be9bc>] (rt2800usb_txstatus_pending+0x1c/0x70 [rt2800usb])
[12785.444301] [<bf1be9bc>] (rt2800usb_txstatus_pending [rt2800usb]) from [<bf1beb64>] (rt2800usb_tx_sta_fifo_read_completed+0xa4/0x150 [rt2800usb])
[12785.457993] [<bf1beb64>] (rt2800usb_tx_sta_fifo_read_completed [rt2800usb]) from [<bf1b7418>] (rt2x00usb_register_read_async_cb+0x20/0x48 [rt2x00usb])
[12785.472139] [<bf1b7418>] (rt2x00usb_register_read_async_cb [rt2x00usb]) from [<c0301aec>] (__usb_hcd_giveback_urb+0x94/0x134)
[12785.483997] [<c0301aec>] (__usb_hcd_giveback_urb) from [<c0301c14>] (usb_giveback_urb_bh+0x88/0xc4)
[12785.493497] [<c0301c14>] (usb_giveback_urb_bh) from [<c00362a8>] (tasklet_action+0x68/0xb8)
[12785.502258] [<c00362a8>] (tasklet_action) from [<c00358d4>] (__do_softirq+0x104/0x364)
[12785.510564] [<c00358d4>] (__do_softirq) from [<c0035b64>] (run_ksoftirqd+0x30/0x40)
[12785.518602] [<c0035b64>] (run_ksoftirqd) from [<c0051edc>] (smpboot_thread_fn+0x108/0x154)
[12785.527282] [<c0051edc>] (smpboot_thread_fn) from [<c004eae4>] (kthread+0xdc/0xf0)
[12785.535229] [<c004eae4>] (kthread) from [<c000f238>] (ret_from_fork+0x14/0x3c)
[12785.542804] Code: e1a00004 e28dd054 e8bd8ff0 e59f3e08 (e5962000)
[12785.549199] ---[ end trace e7152e0c5ad44463 ]---
[12785.554040] Kernel panic - not syncing: Fatal exception in interrupt
[12785.560705] ---[ end Kernel panic - not syncing: Fatal exception in interrupt
mpvader commented 8 years ago

reproduced it by rebooting again, without wifi inserted. and then inserting wifi again as soon as the login prompt showed up.

** Unable to read file boot.scr **
reading uEnv.txt
727 bytes read in 5 ms (141.6 KiB/s)
Loaded environment from uEnv.txt
Importing environment from mmc ...
Running uenvcmd ...
30424 bytes read in 32 ms (927.7 KiB/s)
Loaded bbb-venus.dtb
3652016 bytes read in 236 ms (14.8 MiB/s)
Kernel image @ 0x82000000 [ 0x000000 - 0x37b9b0 ]
## Flattened Device Tree blob at 88000000
   Booting using the fdt blob at 0x88000000
   Loading Device Tree to 8fff5000, end 8ffff6d7 ... OK

Starting kernel ...

[    0.000000] Booting Linux on physical CPU 0x0
[    0.000000] Linux version 4.1.15-venus (matthijs@matthijs-VirtualBox) (gcc version 5.2.0 (GCC) ) #1 Tue May 24 15:38:07 UTC 2016
[    0.000000] CPU: ARMv7 Processor [413fc082] revision 2 (ARMv7), cr=10c5387d
[    0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
[    0.000000] Machine model: TI AM335x BeagleBone Black
[    0.000000] cma: Reserved 16 MiB at 0x9f000000
[    0.000000] Memory policy: Data cache writeback
[    0.000000] CPU: All CPU(s) started in SVC mode.
[    0.000000] AM335X ES2.1 (sgx neon )
[    0.000000] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 130048
[    0.000000] Kernel command line: console=ttyO0,115200n8 consoleblank=0 root=/dev/mmcblk0p2 ro rootfstype=ext4 rootwait
[    0.000000] PID hash table entries: 2048 (order: 1, 8192 bytes)
[    0.000000] Dentry cache hash table entries: 65536 (order: 6, 262144 bytes)
[    0.000000] Inode-cache hash table entries: 32768 (order: 5, 131072 bytes)
[    0.000000] Memory: 487632K/524288K available (4993K kernel code, 322K rwdata, 1748K rodata, 264K init, 8172K bss, 20272K reserved, 16384K cma-reserved, 0K highmem)
[    0.000000] Virtual kernel memory layout:
[    0.000000]     vector  : 0xffff0000 - 0xffff1000   (   4 kB)
[    0.000000]     fixmap  : 0xffc00000 - 0xfff00000   (3072 kB)
[    0.000000]     vmalloc : 0xe0800000 - 0xff000000   ( 488 MB)
[    0.000000]     lowmem  : 0xc0000000 - 0xe0000000   ( 512 MB)
[    0.000000]     pkmap   : 0xbfe00000 - 0xc0000000   (   2 MB)
[    0.000000]     modules : 0xbf000000 - 0xbfe00000   (  14 MB)
[    0.000000]       .text : 0xc0008000 - 0xc069d820   (6743 kB)
[    0.000000]       .init : 0xc069e000 - 0xc06e0000   ( 264 kB)
[    0.000000]       .data : 0xc06e0000 - 0xc0730938   ( 323 kB)
[    0.000000]        .bss : 0xc0730938 - 0xc0f2bb58   (8173 kB)
[    0.000000] Running RCU self tests
[    0.000000] NR_IRQS:16 nr_irqs:16 16
[    0.000000] IRQ: Found an INTC at 0xfa200000 (revision 5.0) with 128 interrupts
[    0.000000] OMAP clockevent source: timer2 at 24000000 Hz
[    0.000013] sched_clock: 32 bits at 24MHz, resolution 41ns, wraps every 89478484971ns
[    0.000034] clocksource timer1: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 79635851949 ns
[    0.000076] OMAP clocksource: timer1 at 24000000 Hz
[    0.000732] Console: colour dummy device 80x30
[    0.000784] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar
[    0.000791] ... MAX_LOCKDEP_SUBCLASSES:  8
[    0.000797] ... MAX_LOCK_DEPTH:          48
[    0.000803] ... MAX_LOCKDEP_KEYS:        8191
[    0.000809] ... CLASSHASH_SIZE:          4096
[    0.000815] ... MAX_LOCKDEP_ENTRIES:     32768
[    0.000821] ... MAX_LOCKDEP_CHAINS:      65536
[    0.000827] ... CHAINHASH_SIZE:          32768
[    0.000833]  memory used by lock dependency info: 5167 kB
[    0.000839]  per task-struct memory footprint: 1152 bytes
[    0.000859] Calibrating delay loop... 996.14 BogoMIPS (lpj=4980736)
[    0.078963] pid_max: default: 32768 minimum: 301
[    0.079169] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes)
[    0.079181] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes)
[    0.081403] CPU: Testing write buffer coherency: ok
[    0.082586] Setting up static identity map for 0x80008200 - 0x80008258
[    0.086578] devtmpfs: initialized
[    0.111341] VFP support v0.3: implementor 41 architecture 3 part 30 variant c rev 3
[    0.147042] omap_hwmod: tptc0 using broken dt data from edma
[    0.147448] omap_hwmod: tptc1 using broken dt data from edma
[    0.147835] omap_hwmod: tptc2 using broken dt data from edma
[    0.155647] omap_hwmod: debugss: _wait_target_disable failed
[    0.210737] clocksource jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[    0.213213] pinctrl core: initialized pinctrl subsystem
[    0.217830] NET: Registered protocol family 16
[    0.222785] DMA: preallocated 256 KiB pool for atomic coherent allocations
[    0.229262] cpuidle: using governor ladder
[    0.229309] cpuidle: using governor menu
[    0.236576] OMAP GPIO hardware version 0.1
[    0.253886] No ATAGs?
[    0.253919] hw-breakpoint: debug architecture 0x4 unsupported.
[    0.320495] edma-dma-engine edma-dma-engine.0: TI EDMA DMA engine driver
[    0.324876] usbcore: registered new interface driver usbfs
[    0.325032] usbcore: registered new interface driver hub
[    0.325179] usbcore: registered new device driver usb
[    0.326065] omap_i2c 44e0b000.i2c: could not find pctldev for node /ocp/l4_wkup@44c00000/scm@210000/pinmux@800/pinmux_i2c0_pins, deferring probe
[    0.329552] Switched to clocksource timer1
[    0.466693] NET: Registered protocol family 2
[    0.468357] TCP established hash table entries: 4096 (order: 2, 16384 bytes)
[    0.468525] TCP bind hash table entries: 4096 (order: 5, 147456 bytes)
[    0.469813] TCP: Hash tables configured (established 4096 bind 4096)
[    0.470031] UDP hash table entries: 256 (order: 2, 20480 bytes)
[    0.470202] UDP-Lite hash table entries: 256 (order: 2, 20480 bytes)
[    0.470949] NET: Registered protocol family 1
[    0.472337] CPU PMU: Failed to parse /pmu/interrupt-affinity[0]
[    0.472403] hw perfevents: enabled with armv7_cortex_a8 PMU driver, 5 counters available
[    0.476057] futex hash table entries: 256 (order: 1, 11264 bytes)
[    0.485071] VFS: Disk quotas dquot_6.6.0
[    0.485172] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[    0.490999] io scheduler noop registered
[    0.491031] io scheduler deadline registered
[    0.491068] io scheduler cfq registered (default)
[    0.494251] pinctrl-single 44e10800.pinmux: 142 pins at pa f9e10800 size 568
[    0.497699] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
[    0.504324] omap_uart 44e09000.serial: no wakeirq for uart0
[    0.504900] 44e09000.serial: ttyO0 at MMIO 0x44e09000 (irq = 154, base_baud = 3000000) is a OMAP UART0
[    1.063650] console [ttyO0] enabled
[    1.070489] omap_uart 48024000.serial: no wakeirq for uart2
[    1.076625] 48024000.serial: ttyO2 at MMIO 0x48024000 (irq = 155, base_baud = 3000000) is a OMAP UART2
[    1.088022] omap_uart 481a8000.serial: no wakeirq for uart4
[    1.094186] 481a8000.serial: ttyO4 at MMIO 0x481a8000 (irq = 156, base_baud = 3000000) is a OMAP UART4
[    1.105472] omap_uart 481aa000.serial: no wakeirq for uart5
[    1.111628] 481aa000.serial: ttyO5 at MMIO 0x481aa000 (irq = 157, base_baud = 3000000) is a OMAP UART5
[    1.124529] omap_rng 48310000.rng: OMAP Random Number Generator ver. 20
[    1.163409] brd: module loaded
[    1.184643] loop: module loaded
[    1.189840] vcan: Virtual CAN interface driver
[    1.194519] slcan: serial line CAN interface driver
[    1.199655] slcan: 10 dynamic interface channels.
[    1.204597] CAN device driver interface
[    1.211187] c_can_platform 481cc000.can: c_can_platform device registered (regs=fa1cc000, irq=162)
[    1.222388] c_can_platform 481d0000.can: c_can_platform device registered (regs=fa1d0000, irq=163)
[    1.233296] usbcore: registered new interface driver asix
[    1.239082] usbcore: registered new interface driver ax88179_178a
[    1.245624] usbcore: registered new interface driver cdc_ether
[    1.251904] usbcore: registered new interface driver smsc95xx
[    1.258029] usbcore: registered new interface driver net1080
[    1.264097] usbcore: registered new interface driver cdc_subset
[    1.270424] usbcore: registered new interface driver zaurus
[    1.276449] usbcore: registered new interface driver cdc_ncm
[    1.292576] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[    1.299446] ehci-omap: OMAP-EHCI Host Controller driver
[    1.305347] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
[    1.312069] usbcore: registered new interface driver cdc_wdm
[    1.318156] usbcore: registered new interface driver usbtest
[    1.326731] 47401300.usb-phy supply vcc not found, using dummy regulator
[    1.343316] 47401b00.usb-phy supply vcc not found, using dummy regulator
[    1.355491] musb-hdrc musb-hdrc.1.auto: MUSB HDRC host driver
[    1.364780] musb-hdrc musb-hdrc.1.auto: new USB bus registered, assigned bus number 1
[    1.374863] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
[    1.382038] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    1.389628] usb usb1: Product: MUSB HDRC host driver
[    1.394833] usb usb1: Manufacturer: Linux 4.1.15-venus musb-hcd
[    1.401053] usb usb1: SerialNumber: musb-hdrc.1.auto
[    1.410433] hub 1-0:1.0: USB hub found
[    1.415223] hub 1-0:1.0: 1 port detected
[    1.425918] mousedev: PS/2 mouse device common for all mice
[    1.435043] i2c /dev entries driver
[    1.438792] Driver for 1-wire Dallas network protocol.
[    1.449054] omap_wdt: OMAP Watchdog Timer Rev 0x01: initial timeout 60 sec
[    1.458580] omap_hsmmc 48060000.mmc: Got CD GPIO
[    1.547089] mmc0: host does not support reading read-only switch, assuming write-enable
[    1.558995] ledtrig-cpu: registered to indicate activity on CPUs
[    1.565869] usbcore: registered new interface driver usbhid
[    1.571746] usbhid: USB HID core driver
[    1.576782] oprofile: using arm/armv7
[    1.581291] Initializing XFRM netlink socket
[    1.586082] NET: Registered protocol family 10
[    1.593249] mmc0: new high speed SDHC card at address b368
[    1.604398] mmcblk0: mmc0:b368       7.45 GiB
[    1.614587] sit: IPv6 over IPv4 tunneling driver
[    1.621773] NET: Registered protocol family 17
[    1.626517] NET: Registered protocol family 15
[    1.631253] can: controller area network core (rev 20120528 abi 9)
[    1.637854] NET: Registered protocol family 29
[    1.642599] can: raw protocol (rev 20120528)
[    1.647212] can: broadcast manager protocol (rev 20120528 t)
[    1.653654] Key type dns_resolver registered
[    1.658305] omap_voltage_late_init: Voltage driver support not added
[    1.665977] ThumbEE CPU extension supported.
[    1.672182]  mmcblk0: p1 p2 p3
[    1.724953] tps65217 0-0024: TPS65217 ID 0xe version 1.2
[    1.730721] omap_i2c 44e0b000.i2c: bus 0 rev0.11 at 400 kHz
[    1.736954] mmc1: MAN_BKOPS_EN bit is not set
[    1.761318] mmc1: new high speed MMC card at address 0001
[    1.768443] mmcblk1: mmc1:0001 MMC04G 3.65 GiB
[    1.773542] mmcblk1boot0: mmc1:0001 MMC04G partition 1 1.00 MiB
[    1.780235] mmcblk1boot1: mmc1:0001 MMC04G partition 2 1.00 MiB
[    1.799664] davinci_mdio 4a101000.mdio: davinci mdio revision 1.6
[    1.806074] davinci_mdio 4a101000.mdio: detected phy mask fffffffe
[    1.815553] libphy: 4a101000.mdio: probed
[    1.819848] davinci_mdio 4a101000.mdio: phy[0]: device 4a101000.mdio:00, driver SMSC LAN8710/LAN8720
[    1.830574] cpsw 4a100000.ethernet: Detected MACID = ec:24:b8:9e:18:df
[    1.840629] hctosys: unable to open rtc device (rtc0)
[    1.870988] EXT4-fs (mmcblk0p2): INFO: recovery required on readonly filesystem
[    1.878676] EXT4-fs (mmcblk0p2): write access will be enabled during recovery
[    5.050802] EXT4-fs (mmcblk0p2): recovery complete
[    5.764180] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
[    5.772856] VFS: Mounted root (ext4 filesystem) readonly on device 179:2.
[    5.785148] devtmpfs: mounted
[    5.788746] Freeing unused kernel memory: 264K (c069e000 - c06e0000)
INIT: version 2.88 booting
mount: mounting devpts on /dev/pts failed: No such file or directory
[    8.333521] EXT4-fs (mmcblk0p3): recovery complete
[    8.450851] EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Opts: (null)
Starting udev
cmp: EOF on /etc/udev/cache.data
udev: Not using udev cache because of changes detected in the following files:
udev:     /proc/version /proc/cmdline /proc/devices
udev:     lib/udev/rules.d/* etc/udev/rules.d/*
udev: The udev cache will be regenerated. To identify the detected changes,
udev: compare the cached sysconf at   /etc/udev/cache.data
udev: against the current sysconf at  /dev/shm/udev.cache
[    8.714288] udevd[661]: starting version 182
[   10.420007] EXT4-fs (mmcblk0p2): re-mounted. Opts: data=ordered
bootlogd: cannot allocate pseudo tty: No such file or directory
[   10.570799] random: dd urandom read with 40 bits of entropy available
Populating dev cache
Sat May 28 10:36:47 UTC 2016
Starting watchdog
[   12.132927] watchdog watchdog0: watchdog did not stop!
INIT: Entering runlevel: 5
Configuring network interfaces... [   12.418421] net eth0: initializing cpsw version 1.12 (0)
[   12.426540] net eth0: phy found : id is : 0x7c0f1
[   12.431632] libphy: PHY 4a101000.mdio:01 not found
[   12.436660] net eth0: phy 4a101000.mdio:01 not found on slave 1
[   12.448739] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
udhcpc (v1.23.2) started
Sending discover...
[   15.500356] cpsw 4a100000.ethernet eth0: Link is Up - 100Mbps/Full - flow control rx/tx
[   15.509350] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
Sending discover...
Sending select for 192.168.51.62...
Lease of 192.168.51.62 obtained, lease time 86400
/etc/udhcpc.d/50default: Adding DNS 192.168.51.254
/etc/udhcpc.d/50default: Adding DNS 213.75.63.75
/etc/udhcpc.d/50default: Adding DNS 213.75.63.76
done.
Starting system message bus: Setting up watches.
Watches established.
/var/run/dbus/ CREATE system_bus_socket
Starting syslogd/klogd: done
Starting php-fpm  done
Starting Connection Manager
Starting Hiawatha Web Server: hiawatha.
Starting crond: OK
Starting simple-upnpd

beaglebone login: root
dbus[905]: [system] Activating service name='fi.w1.wpa_supplicant1' (using servicehelper)
[   26.712097] net eth0: initializing cpsw version 1.12 (0)
[   26.720700] net eth0: phy found : id is : 0x7c0f1
[   26.725753] libphy: PHY 4a101000.mdio:01 not found
[   26.730814] net eth0: phy 4a101000.mdio:01 not found on slave 1
[   26.741367] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
Last login: Sat May 28 15:09:08 +0000 2016 on /dev/ttyO0.
root@beaglebone:~# dbus[905]: [system] Successfully activated service 'fi.w1.wpa_supplicant1'
[   28.720525] cpsw 4a100000.ethernet eth0: Link is Up - 100Mbps/Full - flow control rx/tx
[   28.769731] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[   30.171302] random: nonblocking pool is initialized
[   41.099677] usb 1-1: new high-speed USB device number 2 using musb-hdrc
[   41.255653] usb 1-1: New USB device found, idVendor=0586, idProduct=341e
[   41.262746] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[   41.270251] usb 1-1: Product: 802.11 n WLAN
[   41.274637] usb 1-1: Manufacturer: Ralink
[   41.278839] usb 1-1: SerialNumber: 1.0
[   41.974074] cfg80211: Calling CRDA to update world regulatory domain
[   44.094590] cfg80211: World regulatory domain updated:
[   44.100125] cfg80211:  DFS Master region: unset
[   44.104698] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time)
[   44.114963] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
[   44.123375] cfg80211:   (2457000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
[   44.131781] cfg80211:   (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm), (N/A)
[   44.140189] cfg80211:   (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A)
[   44.150144] cfg80211:   (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s)
[   44.160100] cfg80211:   (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A, 2000 mBm), (0 s)
[   44.168584] cfg80211:   (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A)
[   44.176991] cfg80211:   (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm), (N/A)
[   44.489782] usb 1-1: reset high-speed USB device number 2 using musb-hdrc
[   44.971084] ieee80211 phy0: rt2x00_set_rt: Info - RT chipset 3070, rev 0201 detected
[   45.589759] ieee80211 phy0: rt2x00_set_rf: Info - RF chipset 0005 detected
[   46.088981] usbcore: registered new interface driver rt2800usb
[   46.102788] ieee80211 phy0: rt2x00lib_request_firmware: Info - Loading firmware file 'rt2870.bin'
[   46.279143] ieee80211 phy0: rt2x00lib_request_firmware: Info - Firmware detected - version: 0.29
[   46.988141] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
[   47.959712] ieee80211 phy0: rt2x00usb_vendor_request: Error - Vendor Request 0x07 failed for offset 0x1004 with error -110
[   48.006927] usb 1-1: USB disconnect, device number 2
[   48.020522] ieee80211 phy0: rt2x00usb_vendor_request: Error - Vendor Request 0x06 failed for offset 0x1004 with error -19
[   48.186031] ieee80211 phy0: rt2800usb_tx_sta_fifo_read_completed: Warning - TX status read failed -108
[   48.195834] Unable to handle kernel NULL pointer dereference at virtual address 00000084
[   48.204320] pgd = c0004000
[   48.207155] [00000084] *pgd=00000000
[   48.210914] Internal error: Oops: 17 [#1] ARM
[   48.215482] Modules linked in: arc4 rt2800usb rt2x00usb rt2800lib rt2x00lib mac80211 cfg80211 rfkill ti_am335x_adc kfifo_buf industrialio ti_am335x_tsc ti_am335x_tscadc
[   48.231332] CPU: 0 PID: 53 Comm: kworker/0:1 Not tainted 4.1.15-venus #1
[   48.238358] Hardware name: Generic AM33XX (Flattened Device Tree)
[   48.244762] Workqueue: usb_hub_wq hub_event
[   48.249149] task: de24c040 ti: de256000 task.ti: de256000
[   48.254814] PC is at __lock_acquire+0x1e8/0x1da0
[   48.259654] LR is at 0x1
[   48.262307] pc : [<c0066c74>]    lr : [<00000001>]    psr: 20070193
[   48.262307] sp : de257a70  ip : de256000  fp : c070d974
[   48.274342] r10: c072eda4  r9 : de24c040  r8 : c06f1468
[   48.279817] r7 : c0eee934  r6 : 00000084  r5 : 00000000  r4 : 00000000
[   48.286659] r3 : c0d1db4c  r2 : 00000000  r1 : 00000000  r0 : 00000084
[   48.293502] Flags: nzCv  IRQs off  FIQs on  Mode SVC_32  ISA ARM  Segment kernel
[   48.301255] Control: 10c5387d  Table: 9d5a8019  DAC: 00000015
[   48.307277] Process kworker/0:1 (pid: 53, stack limit = 0xde256210)
[   48.313846] Stack: (0xde257a70 to 0xde258000)
[   48.318414] 7a60:                                     00000000 c02a644c 00000000 de257b44
[   48.326990] 7a80: c0865234 00000000 53425553 45545359 65693d4d 30386565 00313132 49564544
[   48.335566] 7aa0: 2b3d4543 65656569 31323038 68703a31 de003079 de320da0 c0eee934 c06f1468
[   48.344141] 7ac0: de24c040 00000000 80070193 00000084 00000000 00000000 00000000 c072eda4
[   48.352717] 7ae0: 60070193 c006912c 00000001 00000080 00000000 bf195b9c 00000000 c0d6631c
[   48.361292] 7b00: c008b80c 00000001 109c6c1a 00000074 80070193 bf195b9c 000000b8 de320d90
[   48.369868] 7b20: de256000 c072eda4 00000018 c04c1a18 00000001 00000000 bf195b9c c02a68b4
[   48.378444] 7b40: 00000002 00000000 00000074 bf195b9c 00000000 000000b8 dd4a9300 bf1c69bc
[   48.387019] 7b60: dd4a9300 dd027cc0 de320c00 00000000 de320d90 bf1c6b64 00000018 c00665cc
[   48.395594] 7b80: de30d340 bf1bf418 dd027cc0 60070113 de320c00 c0301aec de320d8c de257bb0
[   48.404170] 7ba0: 00000000 de320db0 de320d90 c0301c14 de257bb0 de257bb0 de320db8 00000000
[   48.412747] 7bc0: c06ed3a0 00000000 00000100 c00362a8 c07315d8 00000006 00000040 c072eb10
[   48.421323] 7be0: 00000100 c00358d4 00000001 de012000 00000007 c06f04a0 c0731580 0000000a
[   48.429900] 7c00: ffff9da3 c06f29a0 04208060 00000001 de01125c c070d790 00000000 00000000
[   48.438475] 7c20: 00000001 de012000 00000000 c072eda4 60070013 c0035e68 c070d790 c00729cc
[   48.447051] 7c40: c070dbc0 c0f0c700 de257c70 00000044 00000000 c0009458 c0069144 80070013
[   48.455626] 7c60: ffffffff de257ca4 00000000 c04c2344 00000001 0000000d c0eddd78 de24c040
[   48.464203] 7c80: 00000000 de7fb2d0 de7fb2d8 00000000 00000000 00000000 c072eda4 60070013
[   48.472779] 7ca0: c0759de0 de257cb8 c0731c34 c0069144 80070013 ffffffff 00000001 00000000
[   48.481354] 7cc0: 00000000 c0175e4c 00000000 c01751a0 c0175e4c c006674c c0701954 de7fb2d0
[   48.489929] 7ce0: de7fb2d0 c070d974 c072e6d4 c0175e4c de01c9c0 00000001 00000001 c0175258
[   48.498504] 7d00: 00000001 00000000 c0175e4c 00000000 de7fb630 c0063efc de7fb4d0 00000000
[   48.507080] 7d20: c062a290 c0174d3c 60070013 c04c00cc c062a290 de7fb630 00000000 00000002
[   48.515655] 7d40: 00000000 00000000 00000001 c0175e4c de7fb630 c071ab44 dd670070 c01776d4
[   48.524231] 7d60: c071aad0 dd670068 dd670070 c030c148 c071a760 ffffffff dd670068 c02fa610
[   48.532807] 7d80: c071a760 c004fa10 de199904 00000002 dd670068 ffffffff de314468 de2f1c00
[   48.541382] 7da0: 00000001 c004fd4c 00000000 00000006 de2f1c00 de320878 dd670068 dd67009c
[   48.549958] 7dc0: dd670068 c004fd7c 00000000 c02fe0c8 de2f1c00 c02a60bc dd67009c dd6700c0
[   48.558534] 7de0: 60070013 c04c00cc de320878 dd670000 dd67009c dd670068 de2f1c00 c02fe0d0
[   48.567110] 7e00: dd670000 00000000 00000001 de2f1c00 de314400 00000001 00000000 00000001
[   48.575685] 7e20: de3209dc c02ffb74 c00495d4 c06ef1d0 00000000 de314000 de320800 de31449c
[   48.584262] 7e40: de3208e5 de314400 de320864 de2f1e64 de2f1c08 de320870 de320868 de314020
[   48.592838] 7e60: 00000105 de2f1e64 c071a76c de2f1c00 00000001 c0f11bbc de320c00 de257ec8
[   48.601414] 7e80: 00010105 600f0093 c06ef1c0 de3209dc de206bc0 c06ef1c0 debca900 de257ec8
[   48.609988] 7ea0: c072eb9c c072eb9c 00000000 c0049560 00000001 00000000 c00494c8 c06ef1c0
[   48.618565] 7ec0: c00499d0 00000000 c0f11c14 c087ac94 00000000 c06289d0 c06ef1c0 c06ef1c0
[   48.627141] 7ee0: de206bd8 c06ef1f0 de256000 00000008 c072e553 de206bc0 c06ef1c0 c004995c
[   48.635717] 7f00: c06f29a0 de205d80 de206bc0 00000000 de205d80 de206bc0 c0049910 00000000
[   48.644293] 7f20: 00000000 00000000 00000000 c004eae4 00000001 00000000 00000000 de206bc0
[   48.652868] 7f40: 00000000 00000001 dead4ead ffffffff ffffffff c0731ad4 00000000 00000000
[   48.661444] 7f60: c05ef984 de257f64 de257f64 00000000 00000001 dead4ead ffffffff ffffffff
[   48.670018] 7f80: c0731ad4 00000000 00000000 c05ef984 de257f90 de257f90 de257fac de205d80
[   48.678593] 7fa0: c004ea08 00000000 00000000 c000f238 00000000 00000000 00000000 00000000
[   48.687168] 7fc0: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000
[   48.695744] 7fe0: 00000000 00000000 00000000 00000000 00000013 00000000 78093675 cf8e62ed
[   48.704327] [<c0066c74>] (__lock_acquire) from [<c006912c>] (lock_acquire+0xac/0x12c)
[   48.712550] [<c006912c>] (lock_acquire) from [<c04c1a18>] (_raw_spin_lock_irqsave+0x3c/0x50)
[   48.721448] [<c04c1a18>] (_raw_spin_lock_irqsave) from [<bf195b9c>] (rt2x00queue_get_entry+0x24/0x7c [rt2x00lib])
[   48.732237] [<bf195b9c>] (rt2x00queue_get_entry [rt2x00lib]) from [<bf1c69bc>] (rt2800usb_txstatus_pending+0x1c/0x70 [rt2800usb])
[   48.744465] [<bf1c69bc>] (rt2800usb_txstatus_pending [rt2800usb]) from [<bf1c6b64>] (rt2800usb_tx_sta_fifo_read_completed+0xa4/0x150 [rt2800usb])
[   48.758159] [<bf1c6b64>] (rt2800usb_tx_sta_fifo_read_completed [rt2800usb]) from [<bf1bf418>] (rt2x00usb_register_read_async_cb+0x20/0x48 [rt2x00usb])
[   48.772301] [<bf1bf418>] (rt2x00usb_register_read_async_cb [rt2x00usb]) from [<c0301aec>] (__usb_hcd_giveback_urb+0x94/0x134)
[   48.784159] [<c0301aec>] (__usb_hcd_giveback_urb) from [<c0301c14>] (usb_giveback_urb_bh+0x88/0xc4)
[   48.793659] [<c0301c14>] (usb_giveback_urb_bh) from [<c00362a8>] (tasklet_action+0x68/0xb8)
[   48.802420] [<c00362a8>] (tasklet_action) from [<c00358d4>] (__do_softirq+0x104/0x364)
[   48.810726] [<c00358d4>] (__do_softirq) from [<c0035e68>] (irq_exit+0xfc/0x130)
[   48.818403] [<c0035e68>] (irq_exit) from [<c00729cc>] (__handle_domain_irq+0x58/0xa8)
[   48.826620] [<c00729cc>] (__handle_domain_irq) from [<c0009458>] (omap_intc_handle_irq+0xc8/0xd0)
[   48.835930] [<c0009458>] (omap_intc_handle_irq) from [<c04c2344>] (__irq_svc+0x44/0x5c)
[   48.844320] Exception stack(0xde257c70 to 0xde257cb8)
[   48.849614] 7c60:                                     00000001 0000000d c0eddd78 de24c040
[   48.858189] 7c80: 00000000 de7fb2d0 de7fb2d8 00000000 00000000 00000000 c072eda4 60070013
[   48.866765] 7ca0: c0759de0 de257cb8 c0731c34 c0069144 80070013 ffffffff
[   48.873704] [<c04c2344>] (__irq_s75e4c>] (kernfs_remove_by_name_ns+0x3c/0x84)
[   48.899175] [<c0175e4c>] (kernfs_remove_by_name_ns) from [<c01776d4>] (sysfs_remove_file_from_group+0x3c/0x60)
[   48.909671] [<c01776d4>] (sysfs_remove_file_from_group) from [<c030c148>] (usb_remove_sysfs_dev_files+0x40/0x50)
[   48.920345] [<c030c148>] (usb_remove_sysfs_dev_files) from [<c02fa610>] (usb_bus_notify+0x88/0x90)
[   48.929745] [<c02fa610>] (usb_bus_notify) from [<c004fa10>] (notifier_call_chain+0x4c/0x8c)
[   48.938505] [<c004fa10>] (notifier_call_chain) from [<c004fd4c>] (__blocking_notifier_call_chain+0x48/0x60)
[   48.948722] [<c004fd4c>] (__blocking_notifier_call_chain) from [<c004fd7c>] (blocking_notifier_call_chain+0x18/0x20)
[   48.959763] [<c004fd7c>] (blocking_notifier_call_chain) from [<c02a60bc>] (dfrom [<c0049560>] (process_one_work+0x190/0x540)
[   48.993531] [<c0049560>] (process_one_work) from [<c004995c>] (worker_thread+0x4c/0x4fc)
[   49.002022] [<c004995c>] (worker_thread) from [<c004eae4>] (kthread+0xdc/0xf0)
[   49.009602] [<c004eae4>] (kthread) from [<c000f238>] (ret_from_fork+0x14/0x3c)
[   49.017176] Code: e1a00004 e28dd054 e8bd8ff0 e59f3e08 (e5962000)
[   49.023573] ---[ end trace 9549616f3d814bd7 ]---
[   49.028415] Kernel panic - not syncing: Fatal exception in interrupt
[   49.035079] ---[ end Kernel panic - not syncing: Fatal exception in interrupt
mpvader commented 8 years ago

issue happens when both ethernet and wifi are enabled at same time.

booting up with ethernet, without wifi: OK. But once wifi inserted, the panic accurs.

booting up with without ethernet, without wifi, ok. and then insterting wifi, still ok. then inserting ethernet: panic. See this one:

[    1.184675] loop: module loaded
[    1.189868] vcan: Virtual CAN interface driver
[    1.194544] slcan: serial line CAN interface driver
[    1.199682] slcan: 10 dynamic interface channels.
[    1.204624] CAN device driver interface
[    1.211204] c_can_platform 481cc000.can: c_can_platform device registered (regs=fa1cc000, irq=162)
[    1.222435] c_can_platform 481d0000.can: c_can_platform device registered (regs=fa1d0000, irq=163)
[    1.233340] usbcore: registered new interface driver asix
[    1.239124] usbcore: registered new interface driver ax88179_178a
[    1.245664] usbcore: registered new interface driver cdc_ether
[    1.251942] usbcore: registered new interface driver smsc95xx
[    1.258067] usbcore: registered new interface driver net1080
[    1.264134] usbcore: registered new interface driver cdc_subset
[    1.270463] usbcore: registered new interface driver zaurus
[    1.276488] usbcore: registered new interface driver cdc_ncm
[    1.292606] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[    1.299474] ehci-omap: OMAP-EHCI Host Controller driver
[    1.305376] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
[    1.312096] usbcore: registered new interface driver cdc_wdm
[    1.318184] usbcore: registered new interface driver usbtest
[    1.326753] 47401300.usb-phy supply vcc not found, using dummy regulator
[    1.343298] 47401b00.usb-phy supply vcc not found, using dummy regulator
[    1.355479] musb-hdrc musb-hdrc.1.auto: MUSB HDRC host driver
[    1.364760] musb-hdrc musb-hdrc.1.auto: new USB bus registered, assigned bus number 1
[    1.374842] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
[    1.382016] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    1.389605] usb usb1: Product: MUSB HDRC host driver
[    1.394811] usb usb1: Manufacturer: Linux 4.1.15-venus musb-hcd
[    1.401031] usb usb1: SerialNumber: musb-hdrc.1.auto
[    1.410384] hub 1-0:1.0: USB hub found
[    1.415166] hub 1-0:1.0: 1 port detected
[    1.426121] mousedev: PS/2 mouse device common for all mice
[    1.435084] i2c /dev entries driver
[    1.438831] Driver for 1-wire Dallas network protocol.
[    1.449108] omap_wdt: OMAP Watchdog Timer Rev 0x01: initial timeout 60 sec
[    1.458629] omap_hsmmc 48060000.mmc: Got CD GPIO
[    1.547110] mmc0: host does not support reading read-only switch, assuming write-enable
[    1.559009] ledtrig-cpu: registered to indicate activity on CPUs
[    1.565889] usbcore: registered new interface driver usbhid
[    1.571764] usbhid: USB HID core driver
[    1.576789] oprofile: using arm/armv7
[    1.581289] Initializing XFRM netlink socket
[    1.586078] NET: Registered protocol family 10
[    1.593289] mmc0: new high speed SDHC card at address b368
[    1.604435] mmcblk0: mmc0:b368       7.45 GiB
[    1.614599] sit: IPv6 over IPv4 tunneling driver
[    1.621778] NET: Registered protocol family 17
[    1.626520] NET: Registered protocol family 15
[    1.631257] can: controller area network core (rev 20120528 abi 9)
[    1.637860] NET: Registered protocol family 29
[    1.642603] can: raw protocol (rev 20120528)
[    1.647212] can: broadcast manager protocol (rev 20120528 t)
[    1.653659] Key type dns_resolver registered
[    1.658309] omap_voltage_late_init: Voltage driver support not added
[    1.665985] ThumbEE CPU extension supported.
[    1.672192]  mmcblk0: p1 p2 p3
[    1.724910] tps65217 0-0024: TPS65217 ID 0xe version 1.2
[    1.730691] omap_i2c 44e0b000.i2c: bus 0 rev0.11 at 400 kHz
[    1.736921] mmc1: MAN_BKOPS_EN bit is not set
[    1.761290] mmc1: new high speed MMC card at address 0001
[    1.768418] mmcblk1: mmc1:0001 MMC04G 3.65 GiB
[    1.773528] mmcblk1boot0: mmc1:0001 MMC04G partition 1 1.00 MiB
[    1.780211] mmcblk1boot1: mmc1:0001 MMC04G partition 2 1.00 MiB
[    1.799681] davinci_mdio 4a101000.mdio: davinci mdio revision 1.6
[    1.806091] davinci_mdio 4a101000.mdio: detected phy mask fffffffe
[    1.815574] libphy: 4a101000.mdio: probed
[    1.819872] davinci_mdio 4a101000.mdio: phy[0]: device 4a101000.mdio:00, driver SMSC LAN8710/LAN8720
[    1.830595] cpsw 4a100000.ethernet: Detected MACID = ec:24:b8:9e:18:df
[    1.840642] hctosys: unable to open rtc device (rtc0)
[    1.870981] EXT4-fs (mmcblk0p2): INFO: recovery required on readonly filesystem
[    1.878670] EXT4-fs (mmcblk0p2): write access will be enabled during recovery
[    2.653367] EXT4-fs (mmcblk0p2): recovery complete
[    2.664553] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
[    2.673260] VFS: Mounted root (ext4 filesystem) readonly on device 179:2.
[    2.685808] devtmpfs: mounted
[    2.689409] Freeing unused kernel memory: 264K (c069e000 - c06e0000)
INIT: version 2.88 booting
mount: mounting devpts on /dev/pts failed: No such file or directory
[    4.651593] EXT4-fs (mmcblk0p3): recovery complete
[    4.768828] EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Opts: (null)
Starting udev
cmp: EOF on /etc/udev/cache.data
udev: Not using udev cache because of changes detected in the following files:
udev:     /proc/version /proc/cmdline /proc/devices
udev:     lib/udev/rules.d/* etc/udev/rules.d/*
udev: The udev cache will be regenerated. To identify the detected changes,
udev: compare the cached sysconf at   /etc/udev/cache.data
udev: against the current sysconf at  /dev/shm/udev.cache
[    5.031972] udevd[661]: starting version 182
[    6.569281] EXT4-fs (mmcblk0p2): re-mounted. Opts: data=ordered
bootlogd: cannot allocate pseudo tty: No such file or directory
[    6.713604] random: dd urandom read with 31 bits of entropy available
Populating dev cache
Sat May 28 10:36:47 UTC 2016
Starting watchdog
[    7.869281] watchdog watchdog0: watchdog did not stop!
INIT: Entering runlevel: 5
Configuring network interfaces... [    8.147558] net eth0: initializing cpsw version 1.12 (0)
[    8.155677] net eth0: phy found : id is : 0x7c0f1
[    8.160768] libphy: PHY 4a101000.mdio:01 not found
[    8.165796] net eth0: phy 4a101000.mdio:01 not found on slave 1
[    8.177866] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
udhcpc (v1.23.2) started
Sending discover...
Sending discover...
Sending discover...
No lease, forking to background
done.
Starting system message bus: Setting up watches.
Watches established.
/var/run/dbus/ CREATE system_bus_socket
Starting syslogd/klogd: done
Starting php-fpm  done
Starting Connection Manager
Starting Hiawatha Web Server: hiawatha.
Starting crond: OK
Starting simple-upnpd

beaglebone login: dbus[856]: [system] Activating service name='fi.w1.wpa_supplicant1' (using servicehelper)
dbus[856]: [system] Successfully activated service 'fi.w1.wpa_supplicant1'
[   27.619839] usb 1-1: new high-speed USB device number 2 using musb-hdrc
[   27.805611] usb 1-1: New USB device found, idVendor=0586, idProduct=341e
[   27.812724] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[   27.820249] usb 1-1: Product: 802.11 n WLAN
[   27.824635] usb 1-1: Manufacturer: Ralink
[   27.828837] usb 1-1: SerialNumber: 1.0
[   28.713770] cfg80211: Calling CRDA to update world regulatory domain
[   28.837550] cfg80211: World regulatory domain updated:
[   28.843061] cfg80211:  DFS Master region: unset
[   28.847652] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time)
[   28.857904] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
[   28.866312] cfg80211:   (2457000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
[   28.874729] cfg80211:   (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm), (N/A)
[   28.883145] cfg80211:   (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A)
[   28.893101] cfg80211:   (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s)
[   28.903055] cfg80211:   (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A, 2000 mBm), (0 s)
[   28.911551] cfg80211:   (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A)
[   28.919956] cfg80211:   (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm), (N/A)
[   29.419844] usb 1-1: reset high-speed USB device number 2 using musb-hdrc
[   29.602318] ieee80211 phy0: rt2x00_set_rt: Info - RT chipset 3070, rev 0201 detected
[   29.709394] random: nonblocking pool is initialized
[   29.819763] ieee80211 phy0: rt2x00_set_rf: Info - RF chipset 0005 detected
[   29.963547] usbcore: registered new interface driver rt2800usb
[   29.980401] ieee80211 phy0: rt2x00lib_request_firmware: Info - Loading firmware file 'rt2870.bin'
[   30.095829] ieee80211 phy0: rt2x00lib_request_firmware: Info - Firmware detected - version: 0.29
[   30.909064] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
[   40.520046] wlan0: authenticate with 98:fc:11:ae:b5:04
[   40.598863] wlan0: send auth to 98:fc:11:ae:b5:04 (try 1/3)
[   40.607466] wlan0: authenticated
[   40.630957] wlan0: associate with 98:fc:11:ae:b5:04 (try 1/3)
[   40.641062] wlan0: RX AssocResp from 98:fc:11:ae:b5:04 (capab=0x431 status=0 aid=2)
[   40.656190] wlan0: associated
[   40.660148] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready

beaglebone login:
beaglebone login: root
Last login: Sat May 28 10:37:02 +0000 2016 on /dev/ttyO0.
root@beaglebone:~#
root@beaglebone:~#
root@beaglebone:~#
root@beaglebone:~#
root@beaglebone:~# ifconfig
eth0      Link encap:Ethernet  HWaddr EC:24:B8:9E:18:DF
          UP BROADCAST MULTICAST  MTU:1500  Metric:1
          RX packets:0 errors:0 dropped:0 overruns:0 frame:0
          TX packets:0 errors:0 dropped:0 overruns:0 carrier:0
          collisions:0 txqueuelen:1000
          RX bytes:0 (0.0 B)  TX bytes:0 (0.0 B)
          Interrupt:173

lo        Link encap:Local Loopback
          inet addr:127.0.0.1  Mask:255.0.0.0
          inet6 addr: ::1/128 Scope:Host
          UP LOOPBACK RUNNING  MTU:65536  Metric:1
          RX packets:80 errors:0 dropped:0 overruns:0 frame:0
          TX packets:80 errors:0 dropped:0 overruns:0 carrier:0
          collisions:0 txqueuelen:0
          RX bytes:9130 (8.9 KiB)  TX bytes:9130 (8.9 KiB)

wlan0     Link encap:Ethernet  HWaddr 10:7B:EF:C7:79:A4
          inet addr:192.168.51.63  Bcast:192.168.51.255  Mask:255.255.255.0
          inet6 addr: fe80::127b:efff:fec7:79a4/64 Scope:Link
          UP BROADCAST RUNNING MULTICAST  MTU:1500  Metric:1
          RX packets:57 errors:0 dropped:9 overruns:0 frame:0
          TX packets:61 errors:0 dropped:0 overruns:0 carrier:0
          collisions:0 txqueuelen:1000
          RX bytes:5208 (5.0 KiB)  TX bytes:11078 (10.8 KiB)

root@beaglebone:~# [   56.600521] cpsw 4a100000.ethernet eth0: Link is Up - 100Mbps/Full - flow control rx/tx
[   56.609117] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[   59.139753] ieee80211 phy0: rt2x00usb_vendor_request: Error - Vendor Request 0x07 failed for offset 0x101c with error -110
[   59.165863] usb 1-1: USB disconnect, device number 2
[   60.173457] ------------[ cut here ]------------
[   60.178350] WARNING: CPU: 0 PID: 844 at /media/venusbuilds/wipbbbjethro/build/tmp-glibc/work-shared/beaglebone/kernel-source/drivers/usb/musb/musb_host.c:128 musb_h_tx_flush_fifo+0xdc/0xe4()
[   60.196123] Could not flush host TX2 fifo: csr: 2003
[   60.201324] Modules linked in: ctr ccm arc4 rt2800usb rt2x00usb rt2800lib rt2x00lib mac80211 cfg80211 rfkill ti_am335x_adc kfifo_buf industrialio ti_am335x_tsc ti_am335x_tscadc
[   60.217923] CPU: 0 PID: 844 Comm: kworker/0:2 Not tainted 4.1.15-venus #1
[   60.225037] Hardware name: Generic AM33XX (Flattened Device Tree)
[   60.231434] Workqueue: usb_hub_wq hub_event
[   60.235848] [<c00147c4>] (unwind_backtrace) from [<c0012914>] (show_stack+0x10/0x14)
[   60.243981] [<c0012914>] (show_stack) from [<c00325d0>] (warn_slowpath_common+0x84/0xb0)
[   60.252469] [<c00325d0>] (warn_slowpath_common) from [<c003262c>] (warn_slowpath_fmt+0x30/0x40)
[   60.261595] [<c003262c>] (warn_slowpath_fmt) from [<c032e9f4>] (musb_h_tx_flush_fifo+0xdc/0xe4)
[   60.270723] [<c032e9f4>] (musb_h_tx_flush_fifo) from [<c032f8c4>] (musb_cleanup_urb+0x50/0xe0)
[   60.279757] [<c032f8c4>] (musb_cleanup_urb) from [<c032fe8c>] (musb_urb_dequeue+0xf0/0x130)
[   60.288520] [<c032fe8c>] (musb_urb_dequeue) from [<c0303e5c>] (usb_hcd_flush_endpoint+0xe0/0xfc)
[   60.297739] [<c0303e5c>] (usb_hcd_flush_endpoint) from [<c03065d4>] (usb_disable_endpoint+0x8c/0x94)
[   60.307319] [<c03065d4>] (usb_disable_endpoint) from [<c0306620>] (usb_disable_interface+0x44/0x54)
[   60.316810] [<c0306620>] (usb_disable_interface) from [<c0308c4c>] (usb_unbind_interface+0x1e8/0x278)
[   60.326490] [<c0308c4c>] (usb_unbind_interface) from [<c02a932c>] (__device_release_driver+0x70/0xe4)
[   60.336161] [<c02a932c>] (__device_release_driver) from [<c02a93c0>] (device_release_driver+0x20/0x2c)
[   60.345923] [<c02a93c0>] (device_release_driver) from [<c02a8e18>] (bus_remove_device+0xdc/0x108)
[   60.355230] [<c02a8e18>] (bus_remove_device) from [<c02a619c>] (device_del+0x110/0x210)
[   60.363626] [<c02a619c>] (device_del) from [<c03066d0>] (usb_disable_device+0xa0/0x1e8)
[   60.372020] [<c03066d0>] (usb_disable_device) from [<c02fe040>] (usb_disconnect+0x74/0x280)
[   60.380779] [<c02fe040>] (usb_disconnect) from [<c02ffb74>] (hub_event+0x55c/0x10a8)
[   60.388905] [<c02ffb74>] (hub_event) from [<c0049560>] (process_one_work+0x190/0x540)
[   60.397118] [<c0049560>] (process_one_work) from [<c004995c>] (worker_thread+0x4c/0x4fc)
[   60.405610] [<c004995c>] (worker_thread) from [<c004eae4>] (kthread+0xdc/0xf0)
[   60.413186] [<c004eae4>] (kthread) from [<c000f238>] (ret_from_fork+0x14/0x3c)
[   60.420757] ---[ end trace 4fad142e998efc26 ]---
[   60.448220] ieee80211 phy0: rt2x00usb_vendor_request: Error - Vendor Request 0x06 failed for offset 0x101c with error -110
[   60.530947] wlan0: deauthenticating from 98:fc:11:ae:b5:04 by local choice (Reason: 3=DEAUTH_LEAVING)
[   60.628897] ieee80211 phy0: rt2800usb_tx_sta_fifo_read_completed: Warning - TX status read failed -108
[   60.638703] Unable to handle kernel NULL pointer dereference at virtual address 00000084
[   60.647188] pgd = c0004000
[   60.650022] [00000084] *pgd=00000000
[   60.653782] Internal error: Oops: 17 [#1] ARM
[   60.658350] Modules linked in: ctr ccm arc4 rt2800usb rt2x00usb rt2800lib rt2x00lib mac80211 cfg80211 rfkill ti_am335x_adc kfifo_buf industrialio ti_am335x_tsc ti_am335x_tscadc
[   60.674937] CPU: 0 PID: 3 Comm: ksoftirqd/0 Tainted: G        W       4.1.15-venus #1
[   60.683145] Hardware name: Generic AM33XX (Flattened Device Tree)
[   60.689532] task: de08c040 ti: de096000 task.ti: de096000
[   60.695203] PC is at __lock_acquire+0x1e8/0x1da0
[   60.700043] LR is at 0x1
[   60.702696] pc : [<c0066c74>]    lr : [<00000001>]    psr: 20070093
[   60.702696] sp : de097d48  ip : de096000  fp : c070d974
[   60.714730] r10: c072eda4  r9 : de08c040  r8 : c06f1468
[   60.720205] r7 : c0eee934  r6 : 00000084  r5 : 00000000  r4 : 00000000
[   60.727047] r3 : c0d1db4c  r2 : 00000000  r1 : 00000000  r0 : 00000084
[   60.733890] Flags: nzCv  IRQs off  FIQs on  Mode SVC_32  ISA ARM  Segment kernel
[   60.741643] Control: 10c5387d  Table: 9d6d0019  DAC: 00000015
[   60.747664] Process ksoftirqd/0 (pid: 3, stack limit = 0xde096210)
[   60.754141] Stack: (0xde097d48 to 0xde098000)
[   60.758709] 7d40:                   00000000 c02a644c 00000000 de097e1c 001fe050 00000000
[   60.767285] 7d60: 53425553 45545359 65693d4d 30386565 00313132 49564544 2b3d4543 65656569
[   60.775859] 7d80: 31323038 68703a31 de003079 de2e6da0 c0eee934 c06f1468 de08c040 00000000
[   60.784434] 7da0: 80070093 00000084 00000000 00000000 00000000 c072eda4 60070093 c006912c
[   60.793010] 7dc0: 00000001 00000080 00000000 bf195b9c 00000000 c0d6631c de08c040 00000000
[   60.801585] 7de0: c070d974 00000074 80070093 bf195b9c 000000b8 de2e6d90 de096000 00000000
[   60.810159] 7e00: 00000018 c04c1a18 00000001 00000000 bf195b9c c02a68b4 00000002 00000000
[   60.818735] 7e20: 00000074 bf195b9c 00000000 000000b8 dd53d300 bf1c69bc dd53d300 dd657a40
[   60.827310] 7e40: de2e6c00 00000000 de2e6d90 bf1c6b64 de2e6d8c de2e6d90 d9953680 bf1bf418
[   60.835885] 7e60: dd657a40 60070013 de2e6c00 c0301aec de2e6d8c de097e88 00000000 de2e6db0
[   60.844460] 7e80: de2e6d90 c0301c14 de097e88 de097e88 de2e6db8 00000000 c06ed3a0 00000000
[   60.853036] 7ea0: 00000100 c00362a8 c07315d8 00000006 00000240 c072eb10 00000100 c00358d4
[   60.861611] 7ec0: c06eff30 00000000 00000007 c06f04a0 c0731580 0000000a ffffa27f c06f29a0
[   60.870186] 7ee0: 04208040 00000000 de096000 de028800 de096000 00000000 00000001 c06ed3b4
[   60.878761] 7f00: 00000000 00000000 00000000 c0035b64 de028800 c0051edc 00000000 de0287c0
[   60.887336] 7f20: de028800 c0051dd4 00000000 c004eae4 00000001 00000001 00000000 de028800
[   60.895913] 7f40: 00000000 00000001 dead4ead ffffffff ffffffff c0731ad4 c0868ca4 00000000
[   60.904488] 7f60: c05ef984 de097f64 de097f64 00000000 00000001 dead4ead ffffffff ffffffff
[   60.913063] 7f80: c0731ad4 00000000 00000000 c05ef984 de097f90 de097f90 de097fac de0287c0
[   60.921639] 7fa0: c004ea08 00000000 00000000 c000f238 00000000 00000000 00000000 00000000
[   60.930213] 7fc0: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000
[   60.938789] 7fe0: 00000000 00000000 00000000 00000000 00000013 00000000 78093675 cf8e62e9
[   60.947373] [<c0066c74>] (__lock_acquire) from [<c006912c>] (lock_acquire+0xac/0x12c)
[   60.955597] [<c006912c>] (lock_acquire) from [<c04c1a18>] (_raw_spin_lock_irqsave+0x3c/0x50)
[   60.964495] [<c04c1a18>] (_raw_spin_lock_irqsave) from [<bf195b9c>] (rt2x00queue_get_entry+0x24/0x7c [rt2x00lib])
[   60.975285] [<bf195b9c>] (rt2x00queue_get_entry [rt2x00lib]) from [<bf1c69bc>] (rt2800usb_txstatus_pending+0x1c/0x70 [rt2800usb])
[   60.987514] [<bf1c69bc>] (rt2800usb_txstatus_pending [rt2800usb]) from [<bf1c6b64>] (rt2800usb_tx_sta_fifo_read_completed+0xa4/0x150 [rt2800usb])
[   61.001206] [<bf1c6b64>] (rt2800usb_tx_sta_fifo_read_completed [rt2800usb]) from [<bf1bf418>] (rt2x00usb_register_read_async_cb+0x20/0x48 [rt2x00usb])
[   61.015350] [<bf1bf418>] (rt2x00usb_register_read_async_cb [rt2x00usb]) from [<c0301aec>] (__usb_hcd_giveback_urb+0x94/0x134)
[   61.027209] [<c0301aec>] (__usb_hcd_giveback_urb) from [<c0301c14>] (usb_giveback_urb_bh+0x88/0xc4)
[   61.036709] [<c0301c14>] (usb_giveback_urb_bh) from [<c00362a8>] (tasklet_action+0x68/0xb8)
[   61.045470] [<c00362a8>] (tasklet_action) from [<c00358d4>] (__do_softirq+0x104/0x364)
[   61.053775] [<c00358d4>] (__do_softirq) from [<c0035b64>] (run_ksoftirqd+0x30/0x40)
[   61.061813] [<c0035b64>] (run_ksoftirqd) from [<c0051edc>] (smpboot_thread_fn+0x108/0x154)
[   61.070491] [<c0051edc>] (smpboot_thread_fn) from [<c004eae4>] (kthread+0xdc/0xf0)
[   61.078437] [<c004eae4>] (kthread) from [<c000f238>] (ret_from_fork+0x14/0x3c)
[   61.086012] Code: e1a00004 e28dd054 e8bd8ff0 e59f3e08 (e5962000)
[   61.092407] ---[ end trace 4fad142e998efc27 ]---
[   61.097249] Kernel panic - not syncing: Fatal exception in interrupt
[   61.103913] ---[ end Kernel panic - not syncing: Fatal exception in interrupt
jhofstee commented 8 years ago

Hello Matthijs,

If I have to guess it is caused by adding the CRDA package. I am sure adding the package causes problems, but I don't recall what exactly... it might be this ;)

Regards, Jeroen

mpvader commented 8 years ago

Thanks, I'll try without crda. And in case that helps I'll follow instructions for the alternative: https://wireless.wiki.kernel.org/en/developers/regulatory/crda

mpvader commented 8 years ago

This issue made me leave crda out of the venus-bbb builds for now. Causing annoying crda update messages in the console after boot.

If anyone reading this can take the time to find out if it is really necessary / worthwhile to further look into this, please comment.

I see three options: 1) Keep crda out, and do nothing else <- least amount of work! any technical disadvantages of this? 2) Fix crda issue 3) Use the alternative instead of crda itself

mpvader commented 8 years ago

correction: actually crda is still in the WIP-bbbx branches.

mpvader commented 8 years ago

close: unable to reproduce. When this happened, the bbb was powered from a CCGX USB port. Which is not the strongest of USB ports with regards to its power supply. Jeroen has also seen it a long time ago, at that time his bbb was powered via USB as well, from one of the ports on his laptop.