[beagleboard]ログをよく見ればわかったことだった

ノーコメント、ノーログ作戦というものがあるが、さすがにこの歳になると、少々のことでもコメントやログを書かないと思い出せない。
kernelは、コメントは少ないものの、ログはけっこう出てくる。
出すぎて、見過ごしてしまうことすらある。
そう、kernel panicなんかは特に。。。。

ここに、問題としていたlibusbライブラリを使ったlsusbを実行してkernel panicが起きたときのログを再掲しよう。
いや、全部のログを出すのは、今回が初めてのようだ。
長すぎて、切ってたのだ。

# lsusb
cm: Module associated with clock usbhost_48m_fck didn't enable in 100000 tries
Unhandled fault: external abort on non-linefetch (0x1028) at 0xfa064818
Internal error: : 1028 [#1]
last sysfs file: /sys/power/state
Modules linked in:
CPU: 0    Not tainted  (2.6.32.9-gbfdfe99-dirty #7)
PC is at ehci_omap_bus_resume+0xb4/0x390
LR is at omap2_cm_wait_idlest+0x5c/0x84
pc : []    lr : []    psr: 20000093
sp : c9ba7dd0  ip : 00000002  fp : 00000000
r10: 00000000  r9 : c9ba6000  r8 : cf89a000
r7 : 00000004  r6 : 00000000  r5 : cf894000  r4 : cf8940d0
r3 : fa064810  r2 : ffff84c7  r1 : c04201f1  r0 : 00000000
Flags: nzCv  IRQs off  FIQs on  Mode SVC_32  ISA ARM  Segment user
Control: 10c5387d  Table: 89bac019  DAC: 00000015

PC: 0xc020e700:
e700  e594000c e3500000 0a000000 ebf8b184 e5940010 e3500000 0a000000 ebf8b180
e720  e10f3000 f10c0080 e5952098 e3822002 e5852098 e121f003 e59f2318 e28540d0
e740  e59430e0 e5922000 e0633002 e3530000 aa000001 e3a00005 ebf93282 f10c0080
e760  e5953098 e3130002 1a000002 f1080080 e3e0006b ea0000b5 e5943004 e3a06000
e780  e5932008 e5836008 e5943004 e5836010 e5942024 e5943004 e5832014 e5942010
e7a0  e5943004 e5922004 e5832018 e59420f0 e5943004 e5832000 f1080080 e3a00008
e7c0  ebf93268 f10c0080 e594300c e2847080 e203300f ea00000c e5941004 e0811102
e7e0  e5910004 e597e000 e3c02607 e3c2202a e1a0cc3e e31c0001 0a000002 e3100080

LR: 0xc0035c8c:
5c8c  eb0071de e5b45004 e3550000 1affffec e3a00000 e8bd803e c04db5f8 c041fe9b
5cac  c04201c0 e92d41f0 e1a05000 e1a06001 e1a07002 e3a04000 e59f8054 ea000000
5ccc  eb05167c e5953000 e59f0048 e1130006 1a000003 e59f3040 e1540003 da000007
5cec  ea000002 e2844001 e1540008 1afffff3 e1a01007 e59f0024 e59f2024 eb0c8efa
5d0c  e59f0014 e1540000 c3a00000 d3a00001 e8bd81f0 000186a1 000218de 0001869f
5d2c  c04201f1 000186a0 e59f3018 e5933004 e3530000 10821001 17830001 112fff1e
5d4c  e5833000 eafffffd c04db600 e59f3018 e5933000 e3530000 10821001 17830001
5d6c  112fff1e e5833000 eafffffd c04db600 e92d4010 e59f4280 e3a01e1b e5940008

SP: 0xc9ba7d50:
7d50  00000004 cf89a000 c9ba6000 00000000 00000000 c0057060 0000005f c0029070
7d70  ffffffff ffffffff c9ba7dbc 00000000 00000004 c0029a2c 00000000 c04201f1
7d90  ffff84c7 fa064810 cf8940d0 cf894000 00000000 00000004 cf89a000 c9ba6000
7db0  00000000 00000000 00000002 c9ba7dd0 c0035d0c c020e780 20000093 ffffffff
7dd0  cf894000 00000410 00000084 c0378ff0 cf894000 00000410 cf89a000 00000004
7df0  cf89a000 c9ba6000 00000000 c01fc204 cf89a000 00000410 00000000 cf882dc0
7e10  cf89a000 c02000a0 cf89a000 c0200754 cf89a000 00000001 cf89a298 cf882dc0
7e30  cf89a000 c02005e4 c9ad8140 cf235618 c9b9d9c0 cf882dc0 cf89a000 c0204560

R1: 0xc0420171:
0170  63203a64 646c756f 746f6e20 6e696620 504d2064 6e692055 61697469 20726f74
0190  6f6d7768 73252064 333c000a 616d6f3e 77685f70 3a646f6d 3a732520 756f4320
01b0  6e20646c 6920746f 6d65726f 000a7061 70616d6f 6d77685f 203a646f 203a7325
01d0  70616d6f 6d77685f 725f646f 73696765 20726574 75746572 64656e72 0a642520
01f0  3e333c00 203a6d63 75646f4d 6120656c 636f7373 65746169 69772064 63206874
0210  6b636f6c 20732520 6e646964 65207427 6c62616e 6e692065 20642520 65697274
0230  3c000a73 6f703e33 64726577 69616d6f 77203a6e 65746961 6f742064 6f6c206f
0250  6620676e 7020726f 7265776f 616d6f64 25206e69 6f742073 6d6f6320 74656c70
0270  72742065 69736e61 6e6f6974 7261000a 612f6863 6d2f6d72 2d686361 70616d6f

R2: 0xffff8447:
8444  ******** ******** ******** ******** ******** ******** ******** ********
8464  ******** ******** ******** ******** ******** ******** ******** ********
8484  ******** ******** ******** ******** ******** ******** ******** ********
84a4  ******** ******** ******** ******** ******** ******** ******** ********
84c4  ******** ******** ******** ******** ******** ******** ******** ********
84e4  ******** ******** ******** ******** ******** ******** ******** ********
8504  ******** ******** ******** ******** ******** ******** ******** ********
8524  ******** ******** ******** ******** ******** ******** ******** ********
8544  ******** ******** ******** ******** ******** ******** ******** ********

R3: 0xfa064790:
4790  ******** ******** ******** ******** ******** ******** ******** ********
47b0  ******** ******** ******** ******** ******** ******** ******** ********
47d0  ******** ******** ******** ******** ******** ******** ******** ********
47f0  ******** ******** ******** ******** ******** ******** ******** ********
4810  ******** ******** ******** ******** ******** ******** ******** ********
4830  ******** ******** ******** ******** ******** ******** ******** ********
4850  ******** ******** ******** ******** ******** ******** ******** ********
4870  ******** ******** ******** ******** ******** ******** ******** ********

R4: 0xcf894050:
4050  69636865 6463685f 6273753a 00000031 00000000 00000000 00000000 00000000
4070  00000000 c01fcc74 cf894000 c04e09c0 00000000 00000000 cf894088 cf894088
4090  c01fbf64 c0378ff0 00000002 00000023 0000004d fa064800 48064800 00000000
40b0  00000400 00000000 00000000 cf8c93c0 cf8c9340 cf8c92c0 cf8c9240 00000084
40d0  fa064800 fa064810 00000000 00001313 cf8f3980 00000000 00000000 00000100
40f0  ffc02000 8f851000 00000003 cf8bd000 ffffffff 00000000 cf894108 cf894108
4110  ffffffff 00000000 00000000 00000000 00000000 00000000 00000000 00000000
4130  00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000

R5: 0xcf893f80:
3f80  c01788e0 cf868f08 00000000 cf88a100 00000000 c00613d4 00000000 00000000
3fa0  cf88a100 c0064930 cf893fa8 cf893fa8 cf823f10 cf893fd4 c0061354 cf868f00
3fc0  00000000 00000000 00000000 c0064538 00000000 00000000 cf893fd8 cf893fd8
3fe0  00000000 00000000 00000000 00000000 00000000 c002aecc 00ffcf01 307ffc10
4000  c04adca8 00000001 cf87a680 00000001 00000002 00000002 00000000 00000000
4020  00000000 cf89a000 c04caf0c cf81d028 00000000 00000000 00000000 cf401318
4040  00000000 00000000 00000002 c0447063 69636865 6463685f 6273753a 00000031
4060  00000000 00000000 00000000 00000000 00000000 c01fcc74 cf894000 c04e09c0

R8: 0xcf899f80:
9f80  cf8660c0 cf8660c0 cf899f88 cf8660c0 ffffffff cf899fb0 00000001 cf8661e0
9fa0  cf8660b8 cf8661e0 00000011 c005565c cf899fb0 cf899fb0 00000000 cf8d7540
9fc0  00000000 cf898000 00000000 00000000 00000000 00000000 00000000 c0060b30
9fe0  00000000 00000000 00000000 00000000 00000000 c002aecc 00ffff00 097ffe00
a000  00000001 00000030 00000000 00000000 00000000 00000000 00000008 00000003
a020  00000000 00000000 00000000 00000000 00000000 cf894000 00000507 00000040
a040  00000000 cf89a044 cf89a044 00000000 cf8f1540 00000000 00000000 00000000
a060  00000001 00000000 c04adca8 cf8cce40 cf917600 cf8887ac cf8f178c c04adcb0

R9: 0xc9ba5f80:
5f80  007fff00 00ffff01 04bfdf04 003fcf0c 20ffef01 10ffff00 02f7ff00 00ffff00
5fa0  003fcf00 00fbff00 00fffc02 00b7fe20 80f7ff00 00ff5e00 00fffb80 11f3ff00
5fc0  04bfcf24 00ffef00 007fee00 007fed00 00f3df02 00ffff10 80bfff18 10ffe700
5fe0  00b3ff00 02fffb00 80f7fd10 46bfcf00 00ffff08 007fef20 11bffd00 00fffd14
6000  00000002 00000001 00000000 c9b4a200 c04af240 00000000 00000017 c04aecd0
6020  c9ba6000 c04aec50 c9b4a200 00000000 cf3a5cc0 cf8206c0 c9ba7da4 c9ba7d58
6040  c035a014 00000000 00000000 00000000 00000000 00000000 01010000 00000000
6060  afd4d47c 00000000 00000000 00000000 00000000 00000000 00000000 00000000
Process lsusb (pid: 1102, stack limit = 0xc9ba62e8)
Stack: (0xc9ba7dd0 to 0xc9ba8000)
7dc0:                                     cf894000 00000410 00000084 c0378ff0
7de0: cf894000 00000410 cf89a000 00000004 cf89a000 c9ba6000 00000000 c01fc204
7e00: cf89a000 00000410 00000000 cf882dc0 cf89a000 c02000a0 cf89a000 c0200754
7e20: cf89a000 00000001 cf89a298 cf882dc0 cf89a000 c02005e4 c9ad8140 cf235618
7e40: c9b9d9c0 cf882dc0 cf89a000 c0204560 cf235618 c9b9d9c0 cf235618 c9b9d9c0
7e60: c04ef6c0 00000000 00000000 c00a69ec cf235618 00000000 c9b9d9c0 cf235618
7e80: cf80b240 c00a68cc cf42f118 c00a2644 c9b9d9c0 cf882dc0 c9ba7ef0 00000000
7ea0: cf97e000 c9ba6000 00000001 c00a2824 00000000 cf882dc0 00000026 00020003
7ec0: 00000026 c00aee10 c9b4a200 c9ba7fb0 00000000 00020002 00000000 c9b4a200
7ee0: c9ba7fb0 c003076c 0000efdc 00000817 cf80b240 cf42f118 0000efdc c9ba7fb0
7f00: afd46450 00000000 cf405518 00000101 00000001 00000000 0000f000 cf3a5cc0
7f20: 0000e000 c9b8f6c0 0000000e 00000001 c9b8f6c4 00100077 0000f000 00020003
7f40: 00000000 c9b9d9c0 00000000 00020002 cf8d5cc4 c9ba6000 00000004 00000004
7f60: 00000000 00020002 00000000 cf97e000 c9ba6000 00000000 00000000 c00a23fc
7f80: 00000000 bec92c30 0000d0c8 80004108 00000000 00000005 c002a068 c9ba6000
7fa0: 00000000 c0029ec0 0000d0c8 80004108 bec92c30 00020002 00000000 bec92c44
7fc0: 0000d0c8 80004108 00000000 00000005 bec92c30 00000000 0000d0d0 00000000
7fe0: 80004158 bec92bc0 afd16ffd afd0b4fc 60000010 bec92c30 0077fdff 007bfe40
[] (ehci_omap_bus_resume+0xb4/0x390) from [] (hcd_bus_resume+0x44/0x94)
[] (hcd_bus_resume+0x44/0x94) from [] (usb_resume_device+0x48/0x64)
[] (usb_resume_device+0x48/0x64) from [] (usb_resume_both+0xe4/0x154)
[] (usb_resume_both+0xe4/0x154) from [] (usb_autopm_do_device+0x80/0xf4)
[] (usb_autopm_do_device+0x80/0xf4) from [] (usbdev_open+0xb8/0x1f8)
[] (usbdev_open+0xb8/0x1f8) from [] (chrdev_open+0x120/0x13c)
[] (chrdev_open+0x120/0x13c) from [] (__dentry_open+0x134/0x24c)
[] (__dentry_open+0x134/0x24c) from [] (nameidata_to_filp+0x44/0x58)
[] (nameidata_to_filp+0x44/0x58) from [] (do_filp_open+0x43c/0x808)
[] (do_filp_open+0x43c/0x808) from [] (do_sys_open+0x58/0x144)
[] (do_sys_open+0x58/0x144) from [] (ret_fast_syscall+0x0/0x2c)
Code: e3e0006b ea0000b5 e5943004 e3a06000 (e5932008)
---[ end trace 516e06c4f082a5a8 ]---
Kernel panic - not syncing: Fatal exception

長い。。。
長いので、私はkernel panicになった原因を知ればよかろう、と先頭しか見ていなかった。
non-linefetchを追いつづけていたことからも、それがわかろう。

しかし、kernel panicのお尻には、スタックトレースがついていた。
ふんふん、と眺めてはいたのだが、それほど注視していなかった。

しかしよく考えてみると、
[] (ehci_omap_bus_resume+0xb4/0x390) from [] (hcd_bus_resume+0x44/0x94)
これはちょっと変な気がする。
EHCIって、USB2.0だったはずだ。
BeagleBoardでEHCIが使えるのは、よく見るUSBの平べったいコネクタAタイプだけだったはず。
この図でいうところの、8番。
ここは、使えるか使えないかわからないし、挿しても認識しないので、使ってないのだ。

使っていないところで落ちるってのは、変だろう。
少なくともソフト的な原因であることは間違いない。
ならば、ドライバごと削除してしまえ！

はい、直りました。。。
lsusbもrebootも問題無し。
どうりで、誰もやーやーいわないはずだ。。。
たぶん、覚えていないけど私がEHCIを有効にしたんだろうな。

時間と労力がすごくかかった割には、解決法としてはすっきりしないものがあるが、もうよしとしよう。
EHCIポートが使えないかどうかというのは非常に気になるのだが、別の機会としよう。