Oops in dwc_otg_dump_spram running udevadm

[shirro]

Was going to write some udev rules for usb devices and was running command of form
udevadm info -a -p $(udevadm info -q path -n /dev/mouse0)
or
udevadm info -a -p $(udevadm info -q path -n /dev/sda)
and get kernel oops with latest git kernel and raspbian or debian squeeze

dmesg: https://gist.github.com/2761874

[guisacouto]

I tried this and I also got a crash:\

[kiwironnie]

Similar problem for me exploring ttyUSB0 (with attached USB to serial interface). Crashes consistently irrespective of whether device inserted before or after boot. Darn!

I get the same behavior when doing udevadm info -an /dev/sda.

[slimline33]

I get also a kernel panic when doing

udevadm info -n /dev/ttyUSB0 -a|grep iSerial

Syslog:

Jan 21 00:30:06 raspberrypi kernel: [ 3335.033278] dwc_otg bcm2708_usb: Invalid offset (0xffffffff)
Jan 21 00:30:06 raspberrypi kernel: [ 3335.036871] hsic_connect_show(c0516160) -> platform_dev c0516158, otg_dev dd981640
Jan 21 00:30:06 raspberrypi kernel: [ 3335.044712] guid_show(c0516160) -> platform_dev c0516158, otg_dev dd981640
Jan 21 00:30:06 raspberrypi kernel: [ 3335.048296] mode_show(c0516160) -> platform_dev c0516158, otg_dev dd981640
Jan 21 00:30:06 raspberrypi kernel: [ 3335.051702] srpcapable_show(c0516160) -> platform_dev c0516158, otg_dev dd981640
Jan 21 00:30:06 raspberrypi kernel: [ 3335.059232] Core Global Registers
Jan 21 00:30:06 raspberrypi kernel: [ 3335.063117] GOTGCTL   @0xF2980000 : 0x001C0001
Jan 21 00:30:06 raspberrypi kernel: [ 3335.066226] GOTGINT   @0xF2980004 : 0x00000000
Jan 21 00:30:06 raspberrypi kernel: [ 3335.069136] GAHBCFG   @0xF2980008 : 0x00000031
Jan 21 00:30:06 raspberrypi kernel: [ 3335.073264] GUSBCFG   @0xF298000C : 0x00001700
Jan 21 00:30:06 raspberrypi kernel: [ 3335.076080] GRSTCTL   @0xF2980010 : 0x80000000
Jan 21 00:30:06 raspberrypi kernel: [ 3335.078714] GINTSTS   @0xF2980014 : 0x04200001
Jan 21 00:30:06 raspberrypi kernel: [ 3335.081260] GINTMSK   @0xF2980018 : 0xF300080E
Jan 21 00:30:06 raspberrypi kernel: [ 3335.084982] GRXSTSR   @0xF298001C : 0x00070041
Jan 21 00:30:06 raspberrypi kernel: [ 3335.087445] GRXFSIZ   @0xF2980024 : 0x00000306
Jan 21 00:30:06 raspberrypi kernel: [ 3335.089722] GNPTXFSIZ @0xF2980028 : 0x01000306
Jan 21 00:30:06 raspberrypi kernel: [ 3335.093141] GNPTXSTS  @0xF298002C : 0x18000100
Jan 21 00:30:06 raspberrypi kernel: [ 3335.095355] GI2CCTL   @0xF2980030 : 0x00000000
Jan 21 00:30:06 raspberrypi kernel: [ 3335.097435] GPVNDCTL  @0xF2980034 : 0x00000000
Jan 21 00:30:06 raspberrypi kernel: [ 3335.099437] GGPIO     @0xF2980038 : 0x00000000
Jan 21 00:30:06 raspberrypi kernel: [ 3335.101449] GUID      @0xF298003C : 0x2708A000
Jan 21 00:30:06 raspberrypi kernel: [ 3335.104744] GSNPSID   @0xF2980040 : 0x4F54280A
Jan 21 00:30:06 raspberrypi kernel: [ 3335.106612] GHWCFG1   @0xF2980044 : 0x00000000
Jan 21 00:30:06 raspberrypi kernel: [ 3335.108352] GHWCFG2   @0xF2980048 : 0x228DDD50
Jan 21 00:30:06 raspberrypi kernel: [ 3335.110025] GHWCFG3   @0xF298004C : 0x0FF000E8
Jan 21 00:30:06 raspberrypi kernel: [ 3335.111695] GHWCFG4   @0xF2980050 : 0x1FF00020
Jan 21 00:30:06 raspberrypi kernel: [ 3335.114725] GLPMCFG   @0xF2980054 : 0x75736230
Jan 21 00:30:06 raspberrypi kernel: [ 3335.116227] GPWRDN    @0xF2980058 : 0x00000000
Jan 21 00:30:06 raspberrypi kernel: [ 3335.117686] GDFIFOCFG     @0xF298005C : 0x00000000
Jan 21 00:30:06 raspberrypi kernel: [ 3335.119086] ADPCTL    @0xF2980060 : 0x00000000
Jan 21 00:30:06 raspberrypi kernel: [ 3335.120517] HPTXFSIZ  @0xF2980100 : 0x02000406
Jan 21 00:30:06 raspberrypi kernel: [ 3335.121877] DIENPTXF[1] @0xF2980104 : 0x02000406
Jan 21 00:30:06 raspberrypi kernel: [ 3335.124732] DIENPTXF[2] @0xF2980108 : 0x02000406
Jan 21 00:30:06 raspberrypi kernel: [ 3335.126143] DIENPTXF[3] @0xF298010C : 0x02000406
Jan 21 00:30:06 raspberrypi kernel: [ 3335.127462] DIENPTXF[4] @0xF2980110 : 0x02000406
Jan 21 00:30:06 raspberrypi kernel: [ 3335.128757] DIENPTXF[5] @0xF2980114 : 0x02000406
Jan 21 00:30:06 raspberrypi kernel: [ 3335.130032] DIENPTXF[6] @0xF2980118 : 0x02000406
Jan 21 00:30:06 raspberrypi kernel: [ 3335.131291] DIENPTXF[7] @0xF298011C : 0x02000406
Jan 21 00:30:06 raspberrypi kernel: [ 3335.133990] PCGCCTL   @0xF2980E00 : 0x00000000
Jan 21 00:30:06 raspberrypi kernel: [ 3335.135334] Host Global Registers
Jan 21 00:30:06 raspberrypi kernel: [ 3335.136613] HCFG      @0xF2980400 : 0x00000004
Jan 21 00:30:06 raspberrypi kernel: [ 3335.137897] HFIR      @0xF2980404 : 0x0000EA60
Jan 21 00:30:06 raspberrypi kernel: [ 3335.139164] HFNUM     @0xF2980408 : 0x39D91CF4
Jan 21 00:30:06 raspberrypi kernel: [ 3335.140407] HPTXSTS   @0xF2980410 : 0x31080200
Jan 21 00:30:06 raspberrypi kernel: [ 3335.141672] HAINT     @0xF2980414 : 0x00000000
Jan 21 00:30:06 raspberrypi kernel: [ 3335.144553] HAINTMSK  @0xF2980418 : 0x000000FF
Jan 21 00:30:06 raspberrypi kernel: [ 3335.145933] HPRT0     @0xF2980440 : 0x00021405
Jan 21 00:30:06 raspberrypi kernel: [ 3335.147229] Host Channel 0 Specific Registers
Jan 21 00:30:06 raspberrypi kernel: [ 3335.148536] HCCHAR    @0xF2980500 : 0x00DC9810
Jan 21 00:30:06 raspberrypi kernel: [ 3335.149875] HCSPLT    @0xF2980504 : 0x00000000
Jan 21 00:30:06 raspberrypi kernel: [ 3335.151204] HCINT     @0xF2980508 : 0x00000000
Jan 21 00:30:06 raspberrypi kernel: [ 3335.153998] HCINTMSK  @0xF298050C : 0x00000006
Jan 21 00:30:06 raspberrypi kernel: [ 3335.155468] HCTSIZ    @0xF2980510 : 0x80080010
Jan 21 00:30:06 raspberrypi kernel: [ 3335.156841] HCDMA     @0xF2980514 : 0x5D9A1AC0
Jan 21 00:30:06 raspberrypi kernel: [ 3335.158207] Host Channel 1 Specific Registers
Jan 21 00:30:06 raspberrypi kernel: [ 3335.159589] HCCHAR    @0xF2980520 : 0x00DC9810
Jan 21 00:30:06 raspberrypi kernel: [ 3335.161106] HCSPLT    @0xF2980524 : 0x00000000
Jan 21 00:30:06 raspberrypi kernel: [ 3335.163971] HCINT     @0xF2980528 : 0x00000000
Jan 21 00:30:06 raspberrypi kernel: [ 3335.165441] HCINTMSK  @0xF298052C : 0x00000000
Jan 21 00:30:06 raspberrypi kernel: [ 3335.166849] HCTSIZ    @0xF2980530 : 0x80080010
Jan 21 00:30:06 raspberrypi kernel: [ 3335.168288] HCDMA     @0xF2980534 : 0x5D9A1AC0
Jan 21 00:30:06 raspberrypi kernel: [ 3335.169764] Host Channel 2 Specific Registers
Jan 21 00:30:06 raspberrypi kernel: [ 3335.171279] HCCHAR    @0xF2980540 : 0x00DC9810
Jan 21 00:30:06 raspberrypi kernel: [ 3335.174264] HCSPLT    @0xF2980544 : 0x00000000
Jan 21 00:30:06 raspberrypi kernel: [ 3335.175896] HCINT     @0xF2980548 : 0x00000000
Jan 21 00:30:06 raspberrypi kernel: [ 3335.177566] HCINTMSK  @0xF298054C : 0x00000000
Jan 21 00:30:06 raspberrypi kernel: [ 3335.179107] HCTSIZ    @0xF2980550 : 0x80080010
Jan 21 00:30:06 raspberrypi kernel: [ 3335.180648] HCDMA     @0xF2980554 : 0x5D9A1AC0
Jan 21 00:30:06 raspberrypi kernel: [ 3335.183666] Host Channel 3 Specific Registers
Jan 21 00:30:06 raspberrypi kernel: [ 3335.185321] HCCHAR    @0xF2980560 : 0x00DC9810
Jan 21 00:30:06 raspberrypi kernel: [ 3335.186883] HCSPLT    @0xF2980564 : 0x00000000
Jan 21 00:30:06 raspberrypi kernel: [ 3335.188420] HCINT     @0xF2980568 : 0x00000000
Jan 21 00:30:06 raspberrypi kernel: [ 3335.189946] HCINTMSK  @0xF298056C : 0x00000000
Jan 21 00:30:06 raspberrypi kernel: [ 3335.191472] HCTSIZ    @0xF2980570 : 0x80080010
Jan 21 00:30:06 raspberrypi kernel: [ 3335.194419] HCDMA     @0xF2980574 : 0x5D9A1AC0
Jan 21 00:30:06 raspberrypi kernel: [ 3335.196069] Host Channel 4 Specific Registers
Jan 21 00:30:06 raspberrypi kernel: [ 3335.197642] HCCHAR    @0xF2980580 : 0x00DC9810
Jan 21 00:30:06 raspberrypi kernel: [ 3335.199204] HCSPLT    @0xF2980584 : 0x00000000
Jan 21 00:30:06 raspberrypi kernel: [ 3335.200736] HCINT     @0xF2980588 : 0x00000000
Jan 21 00:30:06 raspberrypi kernel: [ 3335.203582] HCINTMSK  @0xF298058C : 0x00000000
Jan 21 00:30:06 raspberrypi kernel: [ 3335.205187] HCTSIZ    @0xF2980590 : 0x80080010
Jan 21 00:30:06 raspberrypi kernel: [ 3335.206715] HCDMA     @0xF2980594 : 0x5D9A1AC0
Jan 21 00:30:06 raspberrypi kernel: [ 3335.208266] Host Channel 5 Specific Registers
Jan 21 00:30:06 raspberrypi kernel: [ 3335.209831] HCCHAR    @0xF29805A0 : 0x80D88840
Jan 21 00:30:06 raspberrypi kernel: [ 3335.211395] HCSPLT    @0xF29805A4 : 0x00000000
Jan 21 00:30:06 raspberrypi kernel: [ 3335.214406] HCINT     @0xF29805A8 : 0x00000010
Jan 21 00:30:06 raspberrypi kernel: [ 3335.216049] HCINTMSK  @0xF29805AC : 0x00000006
Jan 21 00:30:06 raspberrypi kernel: [ 3335.217602] HCTSIZ    @0xF29805B0 : 0x01000800
Jan 21 00:30:06 raspberrypi kernel: [ 3335.219128] HCDMA     @0xF29805B4 : 0x5E050000
Jan 21 00:30:06 raspberrypi kernel: [ 3335.220666] Host Channel 6 Specific Registers
Jan 21 00:30:06 raspberrypi kernel: [ 3335.223534] HCCHAR    @0xF29805C0 : 0x00DC9810
Jan 21 00:30:06 raspberrypi kernel: [ 3335.225197] HCSPLT    @0xF29805C4 : 0x00000000
Jan 21 00:30:06 raspberrypi kernel: [ 3335.226755] HCINT     @0xF29805C8 : 0x00000000
Jan 21 00:30:06 raspberrypi kernel: [ 3335.228293] HCINTMSK  @0xF29805CC : 0x00000000
Jan 21 00:30:06 raspberrypi kernel: [ 3335.229830] HCTSIZ    @0xF29805D0 : 0x00080010
Jan 21 00:30:06 raspberrypi kernel: [ 3335.231351] HCDMA     @0xF29805D4 : 0x5D9A1AC0
Jan 21 00:30:06 raspberrypi kernel: [ 3335.234364] Host Channel 7 Specific Registers
Jan 21 00:30:06 raspberrypi kernel: [ 3335.236231] HCCHAR    @0xF29805E0 : 0x00DC9810
Jan 21 00:30:06 raspberrypi kernel: [ 3335.237852] HCSPLT    @0xF29805E4 : 0x00000000
Jan 21 00:30:06 raspberrypi kernel: [ 3335.239396] HCINT     @0xF29805E8 : 0x00000000
Jan 21 00:30:06 raspberrypi kernel: [ 3335.240932] HCINTMSK  @0xF29805EC : 0x00000000
Jan 21 00:30:06 raspberrypi kernel: [ 3335.243816] HCTSIZ    @0xF29805F0 : 0x80080010
Jan 21 00:30:06 raspberrypi kernel: [ 3335.245441] HCDMA     @0xF29805F4 : 0x5D9A1AC0
Jan 21 00:30:06 raspberrypi kernel: [ 3335.247239] gpvndctl_show(c0516160) -> platform_dev c0516158, otg_dev dd981640
Jan 21 00:30:06 raspberrypi kernel: [ 3335.249125] ggpio_show(c0516160) -> platform_dev c0516158, otg_dev dd981640
Jan 21 00:30:06 raspberrypi kernel: [ 3335.251057] hprt0_show(c0516160) -> platform_dev c0516158, otg_dev dd981640
Jan 21 00:30:06 raspberrypi kernel: [ 3335.254557] HZ 100, MSEC_PER_JIFFIE 10, loops_per_jiffy 2322432
Jan 21 00:30:06 raspberrypi kernel: [ 3335.682613] gnptxfsiz_show(c0516160) -> platform_dev c0516158, otg_dev dd981640
Jan 21 00:30:06 raspberrypi kernel: [ 3335.684875] WARN::dwc_otg_handle_mode_mismatch_intr:71: Mode Mismatch Interrupt: currently in Host mode
Jan 21 00:30:06 raspberrypi kernel: [ 3335.684875] 
Jan 21 00:30:06 raspberrypi kernel: [ 3335.690480] busconnected_show(c0516160) -> platform_dev c0516158, otg_dev dd981640
Jan 21 00:30:06 raspberrypi kernel: [ 3335.696080] gotgctl_show(c0516160) -> platform_dev c0516158, otg_dev dd981640
Jan 21 00:30:06 raspberrypi kernel: [ 3335.698494] SPRAM Data:
Jan 21 00:30:06 raspberrypi kernel: [ 3335.700608] Base Address: 0xF2980000
Jan 21 00:30:07 raspberrypi kernel: [ 3335.703828] Unable to handle kernel paging request at virtual address f29a8000
Jan 21 00:30:07 raspberrypi kernel: [ 3335.706149] pgd = d969c000
Jan 21 00:30:07 raspberrypi kernel: [ 3335.708359] [f29a8000] *pgd=1dff2841, *pte=00000000, *ppte=00000000
Jan 21 00:30:07 raspberrypi kernel: [ 3335.710752] Internal error: Oops: 27 [#2] PREEMPT ARM
Jan 21 00:30:07 raspberrypi kernel: [ 3335.713054] Modules linked in: ecb md4 nls_utf8 cifs tun snd_bcm2835 snd_pcm snd_page_alloc snd_seq snd_seq_device snd_timer snd leds_gpio led_class ftdi_sio usbserial
Jan 21 00:30:07 raspberrypi kernel: [ 3335.720465] CPU: 0    Tainted: G      D       (3.6.11+ #358)
Jan 21 00:30:07 raspberrypi kernel: [ 3335.722996] PC is at dwc_otg_dump_spram+0x40/0xfc
Jan 21 00:30:07 raspberrypi kernel: [ 3335.725551] LR is at dwc_otg_dump_spram+0x24/0xfc
Jan 21 00:30:07 raspberrypi kernel: [ 3335.728068] pc : [<c0285098>]    lr : [<c028507c>]    psr: 20000013
Jan 21 00:30:07 raspberrypi kernel: [ 3335.728068] sp : dcc95ea0  ip : 60000013  fp : dd983588
Jan 21 00:30:07 raspberrypi kernel: [ 3335.733184] r10: 00001000  r9 : beeb850c  r8 : dcc95f88
Jan 21 00:30:07 raspberrypi kernel: [ 3335.735708] r7 : dcd98138  r6 : dcd98120  r5 : f2980000  r4 : f29a8000
Jan 21 00:30:07 raspberrypi kernel: [ 3335.738230] r3 : f29a80e0  r2 : 20000093  r1 : 00000001  r0 : 00000018
Jan 21 00:30:07 raspberrypi kernel: [ 3335.740804] Flags: nzCv  IRQs on  FIQs on  Mode SVC_32  ISA ARM  Segment user
Jan 21 00:30:07 raspberrypi kernel: [ 3335.743407] Control: 00c5387d  Table: 1969c008  DAC: 00000015
Jan 21 00:30:07 raspberrypi kernel: [ 3335.745978] Process udevadm (pid: 28054, stack limit = 0xdcc94268)
Jan 21 00:30:07 raspberrypi kernel: [ 3335.748539] Stack: (0xdcc95ea0 to 0xdcc96000)
Jan 21 00:30:07 raspberrypi kernel: [ 3335.751041] 5ea0: dcc94000 c00cf868 000080d0 c053bfd7 c051bfd4 c00785bc 00000000 00000002
Jan 21 00:30:07 raspberrypi kernel: [ 3335.756140] 5ec0: dd811db0 dd70d2b0 dcc94000 00000000 dcc95f5c dcc95f78 00000001 dcc42000
Jan 21 00:30:07 raspberrypi kernel: [ 3335.761256] 5ee0: ffffff9c f29a80e0 dcc94000 d9579000 c05312a0 dcd98120 dcd98138 dcc95f88
Jan 21 00:30:07 raspberrypi kernel: [ 3335.766499] 5f00: beeb850c 00001000 dd983588 c02803d8 c0516168 c02349a8 dd98358c c0516168
Jan 21 00:30:07 raspberrypi kernel: [ 3335.771863] 5f20: c03b7ad0 c011e97c 00000001 d96524a8 00000000 d96524a0 beeb850c 00001000
Jan 21 00:30:07 raspberrypi kernel: [ 3335.777339] 5f40: dcc94000 dcc95f88 dcc94000 00000000 beeb9de4 c00c17f0 d96524a8 dd70feb0
Jan 21 00:30:07 raspberrypi kernel: [ 3335.782881] 5f60: d96524a0 00000000 00000000 d96524a0 beeb850c 00001000 00000000 c00c18fc
Jan 21 00:30:07 raspberrypi kernel: [ 3335.788472] 5f80: 00000024 00000000 00000000 00000000 003139e8 00030218 00000003 00000003
Jan 21 00:30:07 raspberrypi kernel: [ 3335.794304] 5fa0: c000dbe8 c000da60 003139e8 00030218 00000003 beeb850c 00001000 00000000
Jan 21 00:30:07 raspberrypi kernel: [ 3335.800346] 5fc0: 003139e8 00030218 00000003 00000003 00313278 00000000 00026df8 beeb9de4
Jan 21 00:30:07 raspberrypi kernel: [ 3335.806591] 5fe0: 00000100 beeb8498 0001b978 b6ea22bc 60000010 00000003 00000000 00000000
Jan 21 00:30:07 raspberrypi kernel: [ 3335.813037] [<c0285098>] (dwc_otg_dump_spram+0x40/0xfc) from [<c02803d8>] (spramdump_show+0x14/0x34)
Jan 21 00:30:07 raspberrypi kernel: [ 3335.819605] [<c02803d8>] (spramdump_show+0x14/0x34) from [<c02349a8>] (dev_attr_show+0x1c/0x48)
Jan 21 00:30:07 raspberrypi kernel: [ 3335.826258] [<c02349a8>] (dev_attr_show+0x1c/0x48) from [<c011e97c>] (sysfs_read_file+0x90/0x134)
Jan 21 00:30:07 raspberrypi kernel: [ 3335.832936] [<c011e97c>] (sysfs_read_file+0x90/0x134) from [<c00c17f0>] (vfs_read+0x98/0x16c)
Jan 21 00:30:07 raspberrypi kernel: [ 3335.839581] [<c00c17f0>] (vfs_read+0x98/0x16c) from [<c00c18fc>] (sys_read+0x38/0x70)
Jan 21 00:30:07 raspberrypi kernel: [ 3335.846222] [<c00c18fc>] (sys_read+0x38/0x70) from [<c000da60>] (ret_fast_syscall+0x0/0x30)
Jan 21 00:30:07 raspberrypi kernel: [ 3335.852849] Code: e28330e0 e1530004 e58d3044 9a000029 (e5d42000) 
Jan 21 00:30:07 raspberrypi kernel: [ 3335.860795] ---[ end trace 8dcb1c1f271ec294 ]---

[popcornmix]

@slimline33 Can your log has been garbled by github. Can you quote it or (even better link to a complete log on pastebin.

[slimline33]

hi pocornmix,

I updated my post. I have no complete syslog. Syslog is empty after reboot...

here is easier to read... : http://pastebin.com/ptBSisKp -> SYSLOG.

[popcornmix]

@slimline33
A complete log is more useful. (To see kernel version, command line arguments, detected USB devices).
What does "uname -a" report?

[myMartek]

I have the same problem. I don't know where to find the log because in /var/log I cannot see any files that contain the error msg.

I only have a sreenshot of my Pi connected to a TV when the crash happens.

uname -a: Linux raspberrypi 3.6.11+ #358 PREEMPT Tue Jan 15 00:45:33 GMT 2013 armv6l GNU/Linux

[slimline33]

@popcornmix

OK. I provoke the kernel panic after a reboot to have a clean syslog...

you can see a full syslog here: http://pastebin.com/tXKTSKG2

uname -a tells me

Linux raspberrypi 3.6.11+ #358 PREEMPT Tue Jan 15 00:45:33 GMT 2013 armv6l GNU/Linux

@myMartek

you can see the syslog /var/log/syslog

watch this with notepad++ over WINSCP!

[myMartek]

Yeah I have a syslog, but there is nothing about the kernel Oops =/

[slimline33]

@myMartek

Post the syslog here http://www.pasebin.com and tell us the link....

[mattsm]

I'm seeing this too ;(

[cleverca22]

http://pastebin.com/RMVEf22P
https://github.com/raspberrypi/linux/blob/rpi-3.6.y/drivers/usb/host/dwc_otg/dwc_otg_cil.c#L4826
[ 107.989851] Base Address: 0xF2980000
[ 107.989926] Unable to handle kernel paging request at virtual address f29a8000

0xF2980000 + 0x00028000 == f29a8000

it looks like its faulting on the address it initially puts into start_addr
but i cant find that same file under the master branch, i'll build a new kernel from master and see what happens

and after reading the code closer, it doesnt even return data, theres no reason for udev to even be triggering it

and on a 3rd look, the master branch isnt even in use!, i'll try 3.10 out anyways