Ticket #11357: psinithang-lockdebug.txt

File psinithang-lockdebug.txt, 52.0 KB (added by greenfeld, 3 years ago)

Log of this hang using a kernel with lock debugging enabled to get more info

Line 
1[  661.982353] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
2[  661.995681] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
3[  662.009447] usb usb1: Product: pxa9xx ehci
4[  662.020112] usb usb1: Manufacturer: Linux 3.0.0_xo1.75-20111201.1013.olpc.8ab3406 ehci_hcd
5[  662.035119] usb usb1: SerialNumber: pxau2o-ehci.0
6[  662.049542] hub 1-0:1.0: USB hub found
7[  662.060120] hub 1-0:1.0: 1 port detected
8[  662.073049] usbcore: registered new interface driver wusb-cbaf
9[  662.085462] Initializing USB Mass Storage driver...
10[  662.096672] usbcore: registered new interface driver usb-storage
11[  662.109130] USB Mass Storage support registered.
12[  662.120538] usbcore: registered new interface driver libusual
13[  662.132634] usbcore: registered new interface driver mdc800
14[  662.144570] mdc800: v0.7.5 (30/10/2000):USB Driver for Mustek MDC800 Digital Camera
15[  662.158851] usbcore: registered new interface driver usbserial
16[  662.171382] USB Serial support registered for generic
17[  662.182988] usbcore: registered new interface driver usbserial_generic
18[  662.195957] usbserial: USB Serial Driver core
19[  662.211127] RAYDIUM_init
20[  662.220569] RAYDIUM_i2c_probe, i2c new style format
21[  662.231672] i2c-core: driver [raydium_ts] using legacy suspend method
22[  662.244327] i2c-core: driver [raydium_ts] using legacy resume method
23[  662.256601] RAYDIUM_i2c_register_device, add i2c device, success
24[  662.268528] RAYDIUM_i2c_register_device, client.addr: 0x30
25[  662.279948] RAYDIUM_i2c_register_device, client.adapter: 0xEE0AA860
26[  662.292547] RAYDIUM_i2c_register_device, client.driver: 0xC04EEA34
27[  662.326830] input: AT Translated Set 2 keyboard as /devices/platform/olpc-kbd.0/serio0/input/input5
28[  662.408973] usb 1-1: new high speed USB device number 2 using pxau2o-ehci
29[  662.570735] usb 1-1: New USB device found, idVendor=05e3, idProduct=0608
30[  662.583398] usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0
31[  662.596414] usb 1-1: Product: USB2.0 Hub
32[  662.607936] hub 1-1:1.0: USB hub found
33[  662.617956] hub 1-1:1.0: 4 ports detected
34[  664.338879] RAYDIUM_i2c_read, i2c read error, ret -121
35[  664.349890] input: raydium_ts as /devices/platform/pxa2xx-i2c.3/i2c-3/3-0030/input/input6
36[  664.364840] RAYDIUM_i2c_register_device, register input device, success
37[  664.377612] RAYDIUM_i2c_register_device, request irq, success
38[  664.389313] mmp-rtc mmp-rtc: rtc core: registered mmp-rtc as rtc0
39[  664.404193] rtc_idt1338 1-0068: rtc core: registered rtc_idt1338 as rtc1
40[  664.417289] lirc_dev: IR Remote Control driver registered, major 252
41[  664.429978] IR RC5 (streamzap) protocol handler initialized
42[  664.441614] IR LIRC bridge handler initialized
43[  664.451943] Linux video capture interface: v2.00
44[  664.618027] sdhci: Secure Digital Host Controller Interface driver
45[  664.630508] sdhci: Copyright(c) Pierre Ossman
46[  664.640773] mmc0: no vmmc regulator found
47[  664.652730] mmc0: SDHCI controller on MMC [sdhci-pxa.0] using DMA
48[  664.665508] mmc1: no vmmc regulator found
49[  664.675972] mmc1: SDHCI controller on MMC [sdhci-pxa.1] using DMA
50[  664.688189] mmc2: no vmmc regulator found
51[  664.698668] mmc2: SDHCI controller on MMC [sdhci-pxa.2] using DMA
52[  664.715842] usbcore: registered new interface driver usbhid
53[  664.727579] usbhid: USB HID core driver
54[  664.737245] i2c-core: driver [olpc_dcon] using legacy suspend method
55[  664.749703] i2c-core: driver [olpc_dcon] using legacy resume method
56[  664.763183] olpc-dcon:  Discovered DCON version 2
57[  664.797262] usbcore: registered new interface driver snd-usb-audio
58[  664.917493] asoc: alc5631-hifi <-> mmp2-i2s.0 mapping ok
59[  664.933728] input: OLPC XO-1.75 Headphone Jack as /devices/platform/soc-audio/sound/card0/input7
60[  664.951663] input: OLPC XO-1.75 Mic Jack as /devices/platform/soc-audio/sound/card0/input8
61[  664.968638] ALSA device list:
62[  664.977890]   #0: OLPC XO-1.75
63[  664.987519] TCP bic registered
64[  664.996466] Initializing XFRM netlink socket
65[  665.006797] NET: Registered protocol family 10
66[  665.019254] NET: Registered protocol family 17
67[  665.030355] lib80211: common routines for IEEE802.11 drivers
68[  665.042010] Registering the dns_resolver key type
69[  665.052666] VFP support v0.3: implementor 56 architecture 2 part 20 variant 9 rev 5
70[  665.066971] ThumbEE CPU extension supported.
71[  665.077334] Registering SWP/SWPB emulation handler
72[  665.087940] PJ4 iWMMXt coprocessor enabled.
73[  665.097980] sram: allocated 4k from d1021000
74[  665.108204] initcall mmp2_pm_init+0x0/0x118 returned with preemption imbalance
75[  665.124171] rtc_idt1338 1-0068: setting system clock to 2000-01-04 06:30:23 UTC (946967423)
76[  665.144100] Freeing init memory: 144K
77[  665.179678] mmc1: new SDIO card at address 0001
78[  665.298973] udev[46]: starting version 161
79[  665.312502] mmc2: new high speed DDR MMC card at address 0001
80[  665.346503] mmcblk0: mmc2:0001 SEM08G 7.39 GiB
81[  665.378968] mmcblk0boot0: mmc2:0001 SEM08G partition 1 1.00 MiB
82[  665.399254] mmcblk0boot1: mmc2:0001 SEM08G partition 2 1.00 MiB
83[  665.430672]  mmcblk0: p1 p2
84[  665.459992]  mmcblk0boot1: unknown partition table
85[  665.493656]  mmcblk0boot0: unknown partition table
86[  667.684419] EXT4-fs (mmcblk0p2): couldn't mount as ext3 due to feature incompatibilities
87[  667.700518] EXT4-fs (mmcblk0p2): couldn't mount as ext2 due to feature incompatibilities
88[  667.729168] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
89[  667.760073] dracut: Mounted root filesystem /dev/disk/mmc/mmc2p2
90[  667.779800] EXT4-fs (mmcblk0p2): warning: maximal mount count reached, running e2fsck is recommended
91[  667.807021] EXT4-fs (mmcblk0p2): re-mounted. Opts: user_xattr,acl,barrier=1,data=ordered
92[  667.836294] EXT4-fs (mmcblk0p1): couldn't mount as ext3 due to feature incompatibilities
93[  667.859922] EXT4-fs (mmcblk0p1): mounting ext2 file system using the ext4 subsystem
94[  667.878655] EXT4-fs (mmcblk0p1): warning: mounting unchecked fs, running e2fsck is recommended
95[  667.894808] EXT4-fs (mmcblk0p1): mounted filesystem without journal. Opts:
96[  668.403801] dcon_freeze_store: 0
97[  668.409466] dcon_source_switch to CPU
98[  668.441580] olpc-dcon: The CPU has control
99[  668.490183] EXT4-fs (mmcblk0p2): re-mounted. Opts: user_xattr,acl,barrier=1,data=ordered
100[  668.686223] dracut: Switching root
101[  669.525716] udev[205]: starting version 161
102[  670.084747] mousedev: PS/2 mouse device common for all mice
103[  670.506231] Finger Sensing Pad, hw: 13.2.1, sw: 1.0.0-K, buttons: 4
104[  670.814730] input: FSPPS/2 Sentelic FingerSensingPad as /devices/platform/olpc-kbd.0/serio1/input/input9
105[  671.471648] libertas_sdio: Libertas SDIO driver
106[  671.473517] libertas_sdio: Copyright Pierre Ossman
107[  672.238021] ov7670 7-0021: chip found @ 0x42 (i2c-gpio7)
108[  672.448902] mmp-camera mmp-camera.0: Release, 0 frames, 0 singles, 0 delivered
109[  673.051511] libertas_sdio mmc1:0001:1: (unregistered net_device): 20:7c:8f:6d:7f:00, fw 9.70.3p36, cap 0x000003a3
110[  673.101373] libertas_sdio mmc1:0001:1: wlan0: Marvell WLAN 802.11 adapter
111[  673.160144] udev[208]: renamed network interface wlan0 to eth0
112[  675.263293] EXT4-fs (mmcblk0p2): warning: maximal mount count reached, running e2fsck is recommended
113[  675.274352] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
114[  676.215767] init: ck-log-system-start main process (560) terminated with status 1
115[  679.885716] ADDRCONF(NETDEV_UP): eth0: link is not ready
116[  680.174023] ieee80211 phy0: assoc: bss   (null) not in scan results
117[  680.259008] dcon_freeze_store: 1
118[  680.269204] dcon_source_switch to DCON
119[  680.311932] olpc-dcon: The DCON has control
120[  682.111891] input: olpc-kbdshim virtual input as /devices/virtual/input/input10
121[  682.176518] ip_tables: (C) 2000-2006 Netfilter Core Team
122[  695.346856] fuse init (API version 7.16)
123[  696.195310] dcon_freeze_store: 0
124[  696.198569] dcon_source_switch to CPU
125[  696.245343] olpc-dcon: The CPU has control
126[  710.871146] dcon_freeze_store: 1
127[  710.878254] dcon_source_switch to DCON
128[  710.919457] olpc-dcon: The DCON has control
129[  711.080692] dcon_freeze_store: 1
130[  711.188864] dcon_freeze_store: 0
131[  711.194780] dcon_source_switch to CPU
132[  711.240253] olpc-dcon: The CPU has control
133
134CForth built 2011-11-30 04:54 from commit 89de5064...
135Using lower core voltage
136Matrix mode on
137releasing
138USB devices:
139/usb@d4208000/hub@0,0
140OLPC 1C1, 1 GiB memory installed, 8 GB internal storage, S/N SHC143009A2
141OpenFirmware  Q4C06   EC Firmware 0.3.05   2000-01-04 06:31:19 UTC
142WARNING!  OS image much smaller than internal storage device
143
144Type any key to interrupt automatic startup
1452 1  Boot device: /sd/disk@3:\boot\olpc.fth  Arguments:
146Boot device: /sd@d4280000/disk@3:\boot\vmlinuz  Arguments:
147Loading ramdisk image from /sd@d4280000/disk@3:\boot\initrd.img ...
148Uncompressing Linux... done, booting the kernel.
149[    0.000000] Initializing cgroup subsys cpu
150[    0.000000] Linux version 3.0.0_xo1.75-20111201.1013.olpc.8ab3406 (martin@koji2.laptop.org) (gcc version 4.5.1 20101112 (Red Hat 4.5.1-5) (GCC) ) #1 PREEMPT Thu Dec 1 11:10:52 EST 2011
151[    0.000000] CPU: ARMv7 Processor [560f5815] revision 5 (ARMv7), cr=10c5387f
152[    0.000000] CPU: VIPT nonaliasing data cache, VIPT aliasing instruction cache
153[    0.000000] Machine: OLPC XO-1.75
154[    0.000000] Ignoring unrecognised tag 0x54410008
155[    0.000000] OFW detected in memory, cif @ 0xfda34f64:
156[    0.000000]   0xfd800000 - 0xfdbfffff (4MB)
157[    0.000000]   0xfdc00000 - 0xfdffffff (4MB)
158[    0.000000] Truncating RAM at 00000000-3f7fffff to -355fffff (vmalloc region overlap).
159[    0.000000] Reserved memory (67108864 bytes at 0x30000000)
160[    0.000000] Memory policy: ECC disabled, Data cache writeback
161[    0.000000] PROM DT: Built device tree with 28672 bytes of memory.
162[    0.000000] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 200532
163[    0.000000] Kernel command line: console=ttyS2,115200 console=tty0 selinux=0 fbcon=font:SUN12x22
164[    0.000000] PID hash table entries: 4096 (order: 2, 16384 bytes)
165[    0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)
166[    0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)
167[    0.000000] Memory: 768MB 22MB = 790MB total
168[    0.000000] Memory: 786804k/786804k available, 87692k reserved, 0K highmem
169[    0.000000] Virtual kernel memory layout:
170[    0.000000]     vector  : 0xffff0000 - 0xffff1000   (   4 kB)
171[    0.000000]     fixmap  : 0xfff00000 - 0xfffe0000   ( 896 kB)
172[    0.000000]     DMA     : 0xff600000 - 0xffe00000   (   8 MB)
173[    0.000000]     vmalloc : 0xf5800000 - 0xfd600000   ( 126 MB)
174[    0.000000]     lowmem  : 0xc0000000 - 0xf5600000   ( 854 MB)
175[    0.000000]     modules : 0xbf000000 - 0xc0000000   (  16 MB)
176[    0.000000]       .init : 0xc0008000 - 0xc002c000   ( 144 kB)
177[    0.000000]       .text : 0xc002c000 - 0xc04cfafc   (4751 kB)
178[    0.000000]       .data : 0xc04d0000 - 0xc0500f90   ( 196 kB)
179[    0.000000]        .bss : 0xc0500fb4 - 0xc0a632a4   (5513 kB)
180[    0.000000] NR_IRQS:320 nr_irqs:320 320
181[    0.000000] sched_clock: 32 bits at 6MHz, resolution 153ns, wraps every 660764ms
182[    0.000000] Console: colour dummy device 80x30
183[    0.000000] console [tty0] enabled
184[    0.000000] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar
185[    0.000000] ... MAX_LOCKDEP_SUBCLASSES:  8
186[    0.000000] ... MAX_LOCK_DEPTH:          48
187[    0.000000] ... MAX_LOCKDEP_KEYS:        8191
188[    0.000000] ... CLASSHASH_SIZE:          4096
189[    0.000000] ... MAX_LOCKDEP_ENTRIES:     16384
190[    0.000000] ... MAX_LOCKDEP_CHAINS:      32768
191[    0.000000] ... CHAINHASH_SIZE:          16384
192[    0.000000]  memory used by lock dependency info: 3695 kB
193[    0.000000]  per task-struct memory footprint: 1152 bytes
194[  660.727659] Calibrating delay loop... 795.44 BogoMIPS (lpj=3977216)
195[  660.817658] pid_max: default: 32768 minimum: 301
196[  660.817669] Mount-cache hash table entries: 512
197[  660.818313] CPU: Testing write buffer coherency: ok
198[  660.828128] devtmpfs: initialized
199[  660.838181] print_constraints: dummy:
200[  660.838181] NET: Registered protocol family 16
201[  660.839083] Tauros2: Disable L2 prefetch, burst8 and WCO.
202[  660.839275] Tauros2: CP15 extra feature register: 0x61000000
203[  660.839313] Tauros2: L2 cache support initialised in ARMv7 mode.
204[  660.839348] u2o_phy_clk_enable
205[  660.840250] mmp-sram vsram: initialized
206[  660.855605] bio: create slab <bio-0> at 0
207[  660.857504] SCSI subsystem initialized
208[  660.857664] usbcore: registered new interface driver usbfs
209[  660.858089] usbcore: registered new interface driver hub
210[  660.858280] usbcore: registered new device driver usb
211[  660.859434] i2c-gpio i2c-gpio.7: using pins 109 (SDA) and 108 (SCL)
212[  660.859434] i2c-gpio i2c-gpio.6: using pins 110 (SDA) and 161 (SCL)
213[  660.859805] i2c-gpio i2c-gpio.2: using pins 5 (SDA) and 4 (SCL)
214[  660.860712] I2C: i2c-3: PXA I2C adapter
215[  660.862407] I2C: i2c-1: PXA I2C adapter
216[  660.862407] I2C: i2c-0: PXA I2C adapter
217[  660.863043] I2C: i2c-5: PXA I2C adapter
218[  660.863828] Advanced Linux Sound Architecture Driver Version 1.0.24.
219[  660.867130] cfg80211: Calling CRDA to update world regulatory domain
220[  660.867820] Switching to clocksource clocksource
221[  660.877772] Switched to NOHz mode on CPU #0
222[  660.886821] NET: Registered protocol family 2
223[  660.887109] IP route cache hash table entries: 32768 (order: 5, 131072 bytes)
224[  660.888973] TCP established hash table entries: 131072 (order: 8, 1048576 bytes)
225[  660.889182] TCP bind hash table entries: 65536 (order: 9, 2359296 bytes)
226[  660.925270] TCP: Hash tables configured (established 131072 bind 65536)
227[  660.925270] TCP reno registered
228[  660.925388] UDP hash table entries: 512 (order: 3, 40960 bytes)
229[  660.925434] UDP-Lite hash table entries: 512 (order: 3, 40960 bytes)
230[  660.925976] NET: Registered protocol family 1
231[  660.927091] Trying to unpack rootfs image as initramfs...
232[  660.968987] Freeing initrd memory: 3712K
233[  660.996242] VFS: Disk quotas dquot_6.5.2
234[  660.996432] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
235[  660.996544] msgmni has been set to 1543
236[  661.001234] io scheduler noop registered
237[  661.001355] io scheduler deadline registered
238[  661.001405] io scheduler cfq registered (default)
239[  661.001534] start plist test
240[  661.006137] end plist test
241[  661.035840] Console: switching to colour frame buffer device 100x40
242[  661.048278] pxa2xx-uart.2: ttyS2 at MMIO 0xd4018000 (irq = 24) is a STUART
243[  661.544588] console [ttyS2] enabled
244[  661.548965] pxa2xx-uart.3: ttyS3 at MMIO 0xd4016000 (irq = 46) is a HWUART
245[  661.557584]
246[  661.557704] [galcore] registerBase =0xd420d000, registerMemSize = 0x0003ffff, contiguousBase= 0x30000000, contiguousSize = 0x03ffffff
247[  661.578954]
248[  661.582351] [galcore] real contiguouSize = 0x03ffffff
249[  661.600292]
250[  661.600292] [galcore] chipModel=0x860,chipRevision=0x4603,chipFeatures=0xe02c6eed,chipMinorFeatures=0xcbf99fff
251[  661.639125] brd: module loaded
252[  661.653858] lis3lv02d: unknown sensor type 0x87
253[  661.664621] lis3lv02d_i2c: probe of 5-001d failed with error -22
254[  661.676919] lis3lv02d: 16 bits sensor found
255[  661.749660] input: ST LIS3LV02DL Accelerometer as /devices/platform/lis3lv02d/input/input0
256[  661.764479] OLPC XO-1.75 Embedded Controller driver probed
257[  661.776905] input: Power Button as /devices/platform/olpc-ec-1.75.0/input/input1
258[  661.795867] OLPC board revision 1C1 (EC api 3)
259[  661.806593] input: OLPC OLS notify as /devices/platform/olpc-ols.0/input/input2
260[  661.821420] OLPC XO-1.75 lid and ebook switches
261[  661.832285] input: OLPC lid switch as /devices/virtual/input/input3
262[  661.845788] input: OLPC ebook switch as /devices/virtual/input/input4
263[  661.858943] usbcore: registered new interface driver ipheth
264[  661.871583] usbcore: registered new interface driver hwa-rc
265[  661.883769] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
266[  661.897294] pxa9xx_ehci_probe: ehci:ef7ced0c, ehci->regs=f5828140
267[  661.909986] pxau2o-ehci pxau2o-ehci.0: pxa9xx ehci
268[  661.924017] pxau2o-ehci pxau2o-ehci.0: new USB bus registered, assigned bus number 1
269[  661.938546] pxau2o-ehci pxau2o-ehci.0: irq 44, io mem 0xd4208000
270[  661.969020] pxau2o-ehci pxau2o-ehci.0: USB 2.0 started, EHCI 1.00
271[  661.982471] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
272[  661.995802] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
273[  662.009588] usb usb1: Product: pxa9xx ehci
274[  662.020259] usb usb1: Manufacturer: Linux 3.0.0_xo1.75-20111201.1013.olpc.8ab3406 ehci_hcd
275[  662.035270] usb usb1: SerialNumber: pxau2o-ehci.0
276[  662.049773] hub 1-0:1.0: USB hub found
277[  662.060137] hub 1-0:1.0: 1 port detected
278[  662.073147] usbcore: registered new interface driver wusb-cbaf
279[  662.085715] Initializing USB Mass Storage driver...
280[  662.096933] usbcore: registered new interface driver usb-storage
281[  662.109425] USB Mass Storage support registered.
282[  662.120314] usbcore: registered new interface driver libusual
283[  662.132953] usbcore: registered new interface driver mdc800
284[  662.144892] mdc800: v0.7.5 (30/10/2000):USB Driver for Mustek MDC800 Digital Camera
285[  662.158944] usbcore: registered new interface driver usbserial
286[  662.172062] USB Serial support registered for generic
287[  662.183348] usbcore: registered new interface driver usbserial_generic
288[  662.196322] usbserial: USB Serial Driver core
289[  662.211491] RAYDIUM_init
290[  662.220950] RAYDIUM_i2c_probe, i2c new style format
291[  662.232162] i2c-core: driver [raydium_ts] using legacy suspend method
292[  662.244696] i2c-core: driver [raydium_ts] using legacy resume method
293[  662.256971] RAYDIUM_i2c_register_device, add i2c device, success
294[  662.268899] RAYDIUM_i2c_register_device, client.addr: 0x30
295[  662.280322] RAYDIUM_i2c_register_device, client.adapter: 0xEE0AA860
296[  662.292924] RAYDIUM_i2c_register_device, client.driver: 0xC04EEA34
297[  662.326919] input: AT Translated Set 2 keyboard as /devices/platform/olpc-kbd.0/serio0/input/input5
298[  662.408966] usb 1-1: new high speed USB device number 2 using pxau2o-ehci
299[  662.570767] usb 1-1: New USB device found, idVendor=05e3, idProduct=0608
300[  662.583423] usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0
301[  662.596449] usb 1-1: Product: USB2.0 Hub
302[  662.607951] hub 1-1:1.0: USB hub found
303[  662.618004] hub 1-1:1.0: 4 ports detected
304[  664.338971] RAYDIUM_i2c_read, i2c read error, ret -121
305[  664.350467] input: raydium_ts as /devices/platform/pxa2xx-i2c.3/i2c-3/3-0030/input/input6
306[  664.364960] RAYDIUM_i2c_register_device, register input device, success
307[  664.377754] RAYDIUM_i2c_register_device, request irq, success
308[  664.390948] mmp-rtc mmp-rtc: rtc core: registered mmp-rtc as rtc0
309[  664.404368] rtc_idt1338 1-0068: rtc core: registered rtc_idt1338 as rtc1
310[  664.417824] lirc_dev: IR Remote Control driver registered, major 252
311[  664.430272] IR RC5 (streamzap) protocol handler initialized
312[  664.441820] IR LIRC bridge handler initialized
313[  664.452185] Linux video capture interface: v2.00
314[  664.618015] sdhci: Secure Digital Host Controller Interface driver
315[  664.630486] sdhci: Copyright(c) Pierre Ossman
316[  664.640832] mmc0: no vmmc regulator found
317[  664.652750] mmc0: SDHCI controller on MMC [sdhci-pxa.0] using DMA
318[  664.665546] mmc1: no vmmc regulator found
319[  664.675949] mmc1: SDHCI controller on MMC [sdhci-pxa.1] using DMA
320[  664.688112] mmc2: no vmmc regulator found
321[  664.698594] mmc2: SDHCI controller on MMC [sdhci-pxa.2] using DMA
322[  664.715199] usbcore: registered new interface driver usbhid
323[  664.726964] usbhid: USB HID core driver
324[  664.736782] i2c-core: driver [olpc_dcon] using legacy suspend method
325[  664.749142] i2c-core: driver [olpc_dcon] using legacy resume method
326[  664.762791] olpc-dcon:  Discovered DCON version 2
327[  664.796042] usbcore: registered new interface driver snd-usb-audio
328[  664.918597] asoc: alc5631-hifi <-> mmp2-i2s.0 mapping ok
329[  664.934546] input: OLPC XO-1.75 Headphone Jack as /devices/platform/soc-audio/sound/card0/input7
330[  664.952452] input: OLPC XO-1.75 Mic Jack as /devices/platform/soc-audio/sound/card0/input8
331[  664.969505] ALSA device list:
332[  664.969505]   #0: OLPC XO-1.75
333[  664.987744] TCP bic registered
334[  664.997329] Initializing XFRM netlink socket
335[  665.007608] NET: Registered protocol family 10
336[  665.020065] NET: Registered protocol family 17
337[  665.031147] lib80211: common routines for IEEE802.11 drivers
338[  665.042802] Registering the dns_resolver key type
339[  665.053448] VFP support v0.3: implementor 56 architecture 2 part 20 variant 9 rev 5
340[  665.067776] ThumbEE CPU extension supported.
341[  665.078119] Registering SWP/SWPB emulation handler
342[  665.088705] PJ4 iWMMXt coprocessor enabled.
343[  665.098733] sram: allocated 4k from d1021000
344[  665.108963] initcall mmp2_pm_init+0x0/0x118 returned with preemption imbalance
345[  665.124907] rtc_idt1338 1-0068: setting system clock to 2000-01-04 06:31:29 UTC (946967489)
346[  665.144792] Freeing init memory: 144K
347[  665.179811] mmc1: new SDIO card at address 0001
348[  665.298191] udev[46]: starting version 161
349[  665.312063] mmc2: new high speed DDR MMC card at address 0001
350[  665.363995] mmcblk0: mmc2:0001 SEM08G 7.39 GiB
351[  665.379417] mmcblk0boot0: mmc2:0001 SEM08G partition 1 1.00 MiB
352[  665.409530] mmcblk0boot1: mmc2:0001 SEM08G partition 2 1.00 MiB
353[  665.440748]  mmcblk0: p1 p2
354[  665.469928]  mmcblk0boot1: unknown partition table
355[  665.496440]  mmcblk0boot0: unknown partition table
356[  667.761803] EXT4-fs (mmcblk0p2): couldn't mount as ext3 due to feature incompatibilities
357[  667.780627] EXT4-fs (mmcblk0p2): couldn't mount as ext2 due to feature incompatibilities
358[  667.798150] EXT4-fs (mmcblk0p2): INFO: recovery required on readonly filesystem
359[  667.811208] EXT4-fs (mmcblk0p2): write access will be enabled during recovery
360[  668.519335] EXT4-fs (mmcblk0p2): recovery complete
361[  668.536413] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
362[  668.561832] dracut: Mounted root filesystem /dev/disk/mmc/mmc2p2
363[  668.582859] EXT4-fs (mmcblk0p2): warning: maximal mount count reached, running e2fsck is recommended
364[  668.613026] EXT4-fs (mmcblk0p2): re-mounted. Opts: user_xattr,acl,barrier=1,data=ordered
365[  668.643325] EXT4-fs (mmcblk0p1): couldn't mount as ext3 due to feature incompatibilities
366[  668.659997] EXT4-fs (mmcblk0p1): mounting ext2 file system using the ext4 subsystem
367[  668.682978] EXT4-fs (mmcblk0p1): warning: mounting unchecked fs, running e2fsck is recommended
368[  668.699400] EXT4-fs (mmcblk0p1): mounted filesystem without journal. Opts:
369[  669.208229] dcon_freeze_store: 0
370[  669.212769] dcon_source_switch to CPU
371[  669.241687] olpc-dcon: The CPU has control
372[  669.304077] EXT4-fs (mmcblk0p2): re-mounted. Opts: user_xattr,acl,barrier=1,data=ordered
373[  669.439198] dracut: Switching root
374[  670.306119] udev[196]: starting version 161
375[  671.100760] mousedev: PS/2 mouse device common for all mice
376[  671.369152] libertas_sdio: Libertas SDIO driver
377[  671.375451] libertas_sdio: Copyright Pierre Ossman
378[  671.861658] Finger Sensing Pad, hw: 13.2.1, sw: 1.0.0-K, buttons: 4
379[  672.638926] input: FSPPS/2 Sentelic FingerSensingPad as /devices/platform/olpc-kbd.0/serio1/input/input9
380[  673.008022] ov7670 7-0021: chip found @ 0x42 (i2c-gpio7)
381[  673.209037] mmp-camera mmp-camera.0: Release, 0 frames, 0 singles, 0 delivered
382[  673.831566] libertas_sdio mmc1:0001:1: (unregistered net_device): 20:7c:8f:6d:7f:00, fw 9.70.3p36, cap 0x000003a3
383[  673.885840] libertas_sdio mmc1:0001:1: wlan0: Marvell WLAN 802.11 adapter
384[  673.949838] udev[199]: renamed network interface wlan0 to eth0
385[  676.136807] EXT4-fs (mmcblk0p2): warning: maximal mount count reached, running e2fsck is recommended
386[  676.148505] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
387[  677.097030] init: ck-log-system-start main process (552) terminated with status 1
388[  680.916028] ADDRCONF(NETDEV_UP): eth0: link is not ready
389[  681.203565] ieee80211 phy0: assoc: bss   (null) not in scan results
390[  681.303524] dcon_freeze_store: 1
391[  681.329123] dcon_source_switch to DCON
392[  681.357673] olpc-dcon: The DCON has control
393[  683.152514] ip_tables: (C) 2000-2006 Netfilter Core Team
394[  683.242749] input: olpc-kbdshim virtual input as /devices/virtual/input/input10
395[  696.410152] fuse init (API version 7.16)
396[  697.211608] dcon_freeze_store: 0
397[  697.214866] dcon_source_switch to CPU
398[  697.271142] olpc-dcon: The CPU has control
399[  713.906700] PM: Syncing filesystems ... done.
400[  713.922172] Freezing user space processes ... (elapsed 0.02 seconds) done.
401[  713.949044] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
402[  713.971645] Suspending console(s) (use no_console_suspend to debug)
403[  713.986327] dcon_source_switch to DCON
404[  714.011862] olpc-dcon: The DCON has control
405[  714.013855] xehci_bus_resume: ehci:ef7ced0c, ehci->regs: f5828140
406[  714.016369] RAYDIUM_i2c_suspend, disable i2c irq
407[  714.017512] libertas_sdio mmc1:0001:1: mmc1:0001:1: suspend: PM flags = 0x3
408[  714.019885] [galcore]: gpu_suspend, 1358
409[  714.019948] >>>>>>[_gpu_off]@1127
410[  714.028978] xehci_bus_resume: ehci:ef7ced0c, ehci->regs: f5828140
411[  714.029024] <<<<<<[_gpu_off]@1145
412[  714.129609] u2o_phy_clk_disable
413[  714.130132] PM: suspend of devices complete after 148.956 msecs
414[  714.132018] PM: late suspend of devices complete after 1.724 msecs
415[  714.134566] PM: early resume of devices complete after 0.526 msecs
416[  714.134688] mmp2_pm_finish
417[  714.136396] ehci:ef7cec00, ehci->regs: 00000001
418[  714.149135] u2o_phy_clk_enable
419[  714.150240] [galcore]: gpu_resume, 1369
420[  714.150359] >>>>>>[_gpu_on]@1153
421[  714.150856] xehci_bus_resume: ehci:ef7ced0c, ehci->regs: f5828140
422[  714.159097] <<<<<<[_gpu_on]@1173
423[  714.159410] mmc1: error -110 during resume (card was removed?)
424[  714.169085] xehci_bus_resume: ehci:ef7ced0c, ehci->regs: f5828140
425[  714.350398] dcon_source_switch to CPU
426[  714.352846] PM: resume of devices complete after 216.913 msecs
427[  714.467750] olpc-dcon: The CPU has control
428[  714.471939] Restarting tasks ...
429[  714.476096] usb 1-1: USB disconnect, device number 2
430[  714.517037] done.
431[  714.589213]
432[  714.589334] =================================
433[  714.589347] [ INFO: inconsistent lock state ]
434[  714.595143] 3.0.0_xo1.75-20111201.1013.olpc.8ab3406 #1
435[  714.599471] ---------------------------------
436[  714.608894] inconsistent {IN-HARDIRQ-W} -> {HARDIRQ-ON-W} usage.
437[  714.608894] kworker/u:7/1143 [HC0[0]:SC0[0]:HE1:SE1] takes:
438[  714.614859]  (&(&host->lock)->rlock){?.-...}, at: [<c0264424>] sdhci_execute_tuning+0x24/0x4d0
439[  714.628983] {IN-HARDIRQ-W} state was registered at:
440[  714.628983]   [<c00722d0>] __lock_acquire+0x5e8/0x18e0
441[  714.633825]   [<c0073a84>] lock_acquire+0x60/0x74
442[  714.638933]   [<c0385928>] _raw_spin_lock+0x40/0x50
443[  714.643602]   [<c0264f38>] sdhci_irq+0x1c/0x8cc
444[  714.648452]   [<c008e2e0>] handle_irq_event_percpu+0x30/0x178
445[  714.658671]   [<c008e464>] handle_irq_event+0x3c/0x5c
446[  714.658671]   [<c0090074>] handle_level_irq+0xb8/0xe8
447[  714.668717]   [<c008de98>] generic_handle_irq+0x20/0x30
448[  714.673911]   [<c002c060>] asm_do_IRQ+0x60/0x84
449[  714.673911]   [<c0031be0>] __irq_svc+0x60/0xac
450[  714.678426]   [<c01ce45c>] __driver_attach+0xc/0x8c
451[  714.682845]   [<c01cd38c>] bus_for_each_dev+0x4c/0x78
452[  714.687704]   [<c01cdb00>] bus_add_driver+0xbc/0x248
453[  714.692727]   [<c01cea28>] driver_register+0xa8/0x12c
454[  714.702686]   [<c002c4c8>] do_one_initcall+0x9c/0x170
455[  714.707710]   [<c00089a8>] kernel_init+0x74/0x118
456[  714.707710]   [<c0032fb8>] kernel_thread_exit+0x0/0x8
457[  714.712387] irq event stamp: 356
458[  714.717411] hardirqs last  enabled at (356): [<c0386228>] _raw_spin_unlock_irqrestore+0x3c/0x6c
459[  714.720608] hardirqs last disabled at (355): [<c0385a1c>] _raw_spin_lock_irqsave+0x18/0x64
460[  714.729257] softirqs last  enabled at (0): [<c00463fc>] copy_process+0x45c/0xf44
461[  714.737477] softirqs last disabled at (0): [<  (null)>]   (null)
462[  714.744835]
463[  714.750805] other info that might help us debug this:
464[  714.750810]  Possible unsafe locking scenario:
465[  714.757291]
466[  714.757291]        CPU0
467[  714.765579]        ----
468[  714.765579]   lock(&(&host->lock)->rlock);
469[  714.768000]   <Interrupt>
470[  714.774669]     lock(&(&host->lock)->rlock);
471[  714.774669]
472[  714.778916]  *** DEADLOCK ***
473[  714.778920]
474[  714.778926] 2 locks held by kworker/u:7/1143:
475[  714.784794]  #0:  (name){++++.+}, at: [<c005af9c>] process_one_work+0x1f4/0x42c
476[  714.789117]  #1:  ((&(&host->detect)->work)){+.+.+.}, at: [<c005af9c>] process_one_work+0x1f4/0x42c
477[  714.796405]
478[  714.805417] stack backtrace:
479[  714.809756] [<c0037ab8>] (unwind_backtrace+0x0/0x120) from [<c0071680>] (print_usage_bug+0x234/0x298)
480[  714.809756] [<c0071680>] (print_usage_bug+0x234/0x298) from [<c0071a28>] (mark_lock+0x344/0x604)
481[  714.818920] [<c0071a28>] (mark_lock+0x344/0x604) from [<c0072364>] (__lock_acquire+0x67c/0x18e0)
482[  714.836374] [<c0072364>] (__lock_acquire+0x67c/0x18e0) from [<c0073a84>] (lock_acquire+0x60/0x74)
483[  714.845187] [<c0073a84>] (lock_acquire+0x60/0x74) from [<c0385928>] (_raw_spin_lock+0x40/0x50)
484[  714.845187] [<c0385928>] (_raw_spin_lock+0x40/0x50) from [<c0264424>] (sdhci_execute_tuning+0x24/0x4d0)
485[  714.853745] [<c0264424>] (sdhci_execute_tuning+0x24/0x4d0) from [<c0264a74>] (sdhci_request+0x1a4/0x1f0)
486[  714.863084] [<c0264a74>] (sdhci_request+0x1a4/0x1f0) from [<c025158c>] (mmc_wait_for_req+0x23c/0x278)
487[  714.872512] [<c025158c>] (mmc_wait_for_req+0x23c/0x278) from [<c0251634>] (mmc_wait_for_cmd+0x6c/0x7c)
488[  714.881673] [<c0251634>] (mmc_wait_for_cmd+0x6c/0x7c) from [<c025862c>] (mmc_io_rw_direct_host+0xbc/0x120)
489[  714.900518] [<c025862c>] (mmc_io_rw_direct_host+0xbc/0x120) from [<c02589ac>] (sdio_reset+0x24/0x60)
490[  714.909597] [<c02589ac>] (sdio_reset+0x24/0x60) from [<c0252e8c>] (mmc_rescan+0x1c8/0x250)
491[  714.909597] [<c0252e8c>] (mmc_rescan+0x1c8/0x250) from [<c005b020>] (process_one_work+0x278/0x42c)
492[  714.917808] [<c005b020>] (process_one_work+0x278/0x42c) from [<c005d0a4>] (worker_thread+0x1e0/0x2e4)
493[  714.926719] [<c005d0a4>] (worker_thread+0x1e0/0x2e4) from [<c0060acc>] (kthread+0x80/0x88)
494[  714.935885] [<c0060acc>] (kthread+0x80/0x88) from [<c0032fb8>] (kernel_thread_exit+0x0/0x8)
495[  714.966480] hub 1-0:1.0: state 7 ports 1 chg 0000 evt 0002
496[  714.987177] pxau2o-ehci pxau2o-ehci.0: GetStatus port:1 status 001803 0  ACK POWER sig=j CSC CONNECT
497[  715.016752] hub 1-0:1.0: port 1, status 0101, change 0001, 12 Mb/s
498[  715.179159] hub 1-0:1.0: debounce: port 1: total 100ms stable 100ms status 0x101
499[  715.239164] pxau2o-ehci pxau2o-ehci.0: port 1 high speed
500[  715.244864] pxau2o-ehci pxau2o-ehci.0: GetStatus port:1 status 8001205 4  ACK POWER sig=se0 LPM PE CONNECT
501[  715.309076] usb 1-1: new high speed USB device number 3 using pxau2o-ehci
502[  715.369453] pxau2o-ehci pxau2o-ehci.0: port 1 high speed
503[  715.369453] pxau2o-ehci pxau2o-ehci.0: GetStatus port:1 status 8001205 4  ACK POWER sig=se0 LPM PE CONNECT
504[  715.470340] usb 1-1: default language 0x0409
505[  715.474939] usb 1-1: udev 3, busnum 1, minor = 2
506[  715.481226] usb 1-1: New USB device found, idVendor=05e3, idProduct=0608
507[  715.481261] usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0
508[  715.495580] usb 1-1: Product: USB2.0 Hub
509[  715.508343] usb 1-1: usb_probe_device
510[  715.512416] usb 1-1: configuration #1 chosen from 1 choice
511[  715.522466] usb 1-1: adding 1-1:1.0 (config #1, interface 0)
512[  715.528701] hub 1-1:1.0: usb_probe_interface
513[  715.536905] hub 1-1:1.0: usb_probe_interface - got id
514[  715.543386] hub 1-1:1.0: USB hub found
515[  715.547457] hub 1-1:1.0: 4 ports detected
516[  715.551975] hub 1-1:1.0: standalone hub
517[  715.555802] hub 1-1:1.0: ganged power switching
518[  715.560601] hub 1-1:1.0: global over-current protection
519[  715.565803] hub 1-1:1.0: Single TT
520[  715.569439] hub 1-1:1.0: TT requires at most 32 FS bit times (2664 ns)
521[  715.569452] hub 1-1:1.0: Port indicators are supported
522[  715.581314] hub 1-1:1.0: power on to power good time: 100ms
523[  715.587438] hub 1-1:1.0: local power source is good
524[  715.592587] hub 1-1:1.0: no over-current condition exists
525[  715.592587] hub 1-1:1.0: enabling power on all ports
526[  715.608170] drivers/usb/core/inode.c: creating file '003'
527[  715.700437] usb 1-1: link qh256-0001/ef7d1720 start 2 [1/0 us]
528[  715.706330] hub 1-1:1.0: state 7 ports 4 chg 0000 evt 0000
529[  717.769119] hub 1-1:1.0: hub_suspend
530[  717.772852] usb 1-1: unlink qh256-0001/ef7d1720 start 2 [1/0 us]
531[  717.782724] usb 1-1: usb auto-suspend
532[  719.799209] hub 1-0:1.0: hub_suspend
533[  719.799209] usb usb1: bus auto-suspend
534[  719.802798] pxau2o-ehci pxau2o-ehci.0: suspend root hub
535[  722.693289] init: olpc-switchd main process (696) terminated with status 1
536[  722.730637] init: olpc-kbdshim-udev main process (698) terminated with status 1
537[  722.779136] init: tty (/dev/tty2) main process (706) killed by TERM signal
538[  722.787201] init: tty (/dev/tty3) main process (710) killed by TERM signal
539[  723.996409] dcon_freeze_store: 0
540[  724.038151] init: plymouth-shutdown main process (1199) terminated with status 1
541[  724.069197] init: splash-manager main process (1184) terminated with status 1
542[  724.505707] dcon_freeze_store: 1
543[  724.510028] dcon_source_switch to DCON
544[  724.550671] olpc-dcon: The DCON has control
545[  725.177259] libertas_sdio: error -110 sending packet to firmware
546[  725.398368] init: Disconnected from system bus
547[  725.667662] init: ttySx main process (177) killed by TERM signal
548[  725.674530] init: ttySx main process ended, respawning
549[  727.679817] init: powerd main process (697) killed by KILL signal
550[  727.703807] init: ttySx main process (1263) killed by KILL signal
551[  727.712089] init: ttySx main process ended, respawning
552[  728.179067] libertas_sdio mmc1:0001:1: eth0: command 0x0010 timed out
553[  728.185537] libertas_sdio mmc1:0001:1: eth0: Timeout submitting command 0x0010
554[  728.442263] idt1338: set time to Y=2000 M=1 D=4,  6:32:33
555[  728.849196] init: Re-executing /sbin/init
556[  728.979309] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
557[  729.170100] psmouse.c: Failed to disable mouse on olpc_touchpad/serio0
558[  729.769106] psmouse serio1: Unable get OPC state.
559[  731.569077] RAYDIUM_i2c_shutdown
560[  731.569234] Restarting system.
561[  732.108478] psmouse serio1: Unexpected absolute mode packet, ignored.
562
563CForth built 2011-11-30 04:54 from commit 89de5064...
564Using lower core voltage
565Matrix mode on
566releasing
567USB devices:
568/usb@d4208000/hub@0,0
569OLPC 1C1, 1 GiB memory installed, 8 GB internal storage, S/N SHC143009A2
570OpenFirmware  Q4C06   EC Firmware 0.3.05   2000-01-04 06:32:40 UTC
571WARNING!  OS image much smaller than internal storage device
572
573Type any key to interrupt automatic startup
5742 1  Boot device: /sd/disk@3:\boot\olpc.fth  Arguments:
575Boot device: /sd@d4280000/disk@3:\boot\vmlinuz  Arguments:
576Loading ramdisk image from /sd@d4280000/disk@3:\boot\initrd.img ...
577Uncompressing Linux... done, booting the kernel.
578[    0.000000] Initializing cgroup subsys cpu
579[    0.000000] Linux version 3.0.0_xo1.75-20111201.1013.olpc.8ab3406 (martin@koji2.laptop.org) (gcc version 4.5.1 20101112 (Red Hat 4.5.1-5) (GCC) ) #1 PREEMPT Thu Dec 1 11:10:52 EST 2011
580[    0.000000] CPU: ARMv7 Processor [560f5815] revision 5 (ARMv7), cr=10c5387f
581[    0.000000] CPU: VIPT nonaliasing data cache, VIPT aliasing instruction cache
582[    0.000000] Machine: OLPC XO-1.75
583[    0.000000] Ignoring unrecognised tag 0x54410008
584[    0.000000] OFW detected in memory, cif @ 0xfda34f64:
585[    0.000000]   0xfd800000 - 0xfdbfffff (4MB)
586[    0.000000]   0xfdc00000 - 0xfdffffff (4MB)
587[    0.000000] Truncating RAM at 00000000-3f7fffff to -355fffff (vmalloc region overlap).
588[    0.000000] Reserved memory (67108864 bytes at 0x30000000)
589[    0.000000] Memory policy: ECC disabled, Data cache writeback
590[    0.000000] PROM DT: Built device tree with 28672 bytes of memory.
591[    0.000000] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 200532
592[    0.000000] Kernel command line: console=ttyS2,115200 console=tty0 selinux=0 fbcon=font:SUN12x22
593[    0.000000] PID hash table entries: 4096 (order: 2, 16384 bytes)
594[    0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)
595[    0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)
596[    0.000000] Memory: 768MB 22MB = 790MB total
597[    0.000000] Memory: 786804k/786804k available, 87692k reserved, 0K highmem
598[    0.000000] Virtual kernel memory layout:
599[    0.000000]     vector  : 0xffff0000 - 0xffff1000   (   4 kB)
600[    0.000000]     fixmap  : 0xfff00000 - 0xfffe0000   ( 896 kB)
601[    0.000000]     DMA     : 0xff600000 - 0xffe00000   (   8 MB)
602[    0.000000]     vmalloc : 0xf5800000 - 0xfd600000   ( 126 MB)
603[    0.000000]     lowmem  : 0xc0000000 - 0xf5600000   ( 854 MB)
604[    0.000000]     modules : 0xbf000000 - 0xc0000000   (  16 MB)
605[    0.000000]       .init : 0xc0008000 - 0xc002c000   ( 144 kB)
606[    0.000000]       .text : 0xc002c000 - 0xc04cfafc   (4751 kB)
607[    0.000000]       .data : 0xc04d0000 - 0xc0500f90   ( 196 kB)
608[    0.000000]        .bss : 0xc0500fb4 - 0xc0a632a4   (5513 kB)
609[    0.000000] NR_IRQS:320 nr_irqs:320 320
610[    0.000000] sched_clock: 32 bits at 6MHz, resolution 153ns, wraps every 660764ms
611[    0.000000] Console: colour dummy device 80x30
612[    0.000000] console [tty0] enabled
613[    0.000000] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar
614[    0.000000] ... MAX_LOCKDEP_SUBCLASSES:  8
615[    0.000000] ... MAX_LOCK_DEPTH:          48
616[    0.000000] ... MAX_LOCKDEP_KEYS:        8191
617[    0.000000] ... CLASSHASH_SIZE:          4096
618[    0.000000] ... MAX_LOCKDEP_ENTRIES:     16384
619[    0.000000] ... MAX_LOCKDEP_CHAINS:      32768
620[    0.000000] ... CHAINHASH_SIZE:          16384
621[    0.000000]  memory used by lock dependency info: 3695 kB
622[    0.000000]  per task-struct memory footprint: 1152 bytes
623[  660.727676] Calibrating delay loop... 795.44 BogoMIPS (lpj=3977216)
624[  660.817675] pid_max: default: 32768 minimum: 301
625[  660.817687] Mount-cache hash table entries: 512
626[  660.818326] CPU: Testing write buffer coherency: ok
627[  660.828143] devtmpfs: initialized
628[  660.837721] print_constraints: dummy:
629[  660.838191] NET: Registered protocol family 16
630[  660.839086] Tauros2: Disable L2 prefetch, burst8 and WCO.
631[  660.839275] Tauros2: CP15 extra feature register: 0x61000000
632[  660.839346] Tauros2: L2 cache support initialised in ARMv7 mode.
633[  660.839346] u2o_phy_clk_enable
634[  660.840250] mmp-sram vsram: initialized
635[  660.855565] bio: create slab <bio-0> at 0
636[  660.856237] SCSI subsystem initialized
637[  660.857834] usbcore: registered new interface driver usbfs
638[  660.857834] usbcore: registered new interface driver hub
639[  660.858241] usbcore: registered new device driver usb
640[  660.858332] i2c-gpio i2c-gpio.7: using pins 109 (SDA) and 108 (SCL)
641[  660.859392] i2c-gpio i2c-gpio.6: using pins 110 (SDA) and 161 (SCL)
642[  660.859762] i2c-gpio i2c-gpio.2: using pins 5 (SDA) and 4 (SCL)
643[  660.860664] I2C: i2c-3: PXA I2C adapter
644[  660.861631] I2C: i2c-1: PXA I2C adapter
645[  660.862364] I2C: i2c-0: PXA I2C adapter
646[  660.862998] I2C: i2c-5: PXA I2C adapter
647[  660.864447] Advanced Linux Sound Architecture Driver Version 1.0.24.
648[  660.867322] cfg80211: Calling CRDA to update world regulatory domain
649[  660.868873] Switching to clocksource clocksource
650[  660.877794] Switched to NOHz mode on CPU #0
651[  660.886725] NET: Registered protocol family 2
652[  660.887594] IP route cache hash table entries: 32768 (order: 5, 131072 bytes)
653[  660.888976] TCP established hash table entries: 131072 (order: 8, 1048576 bytes)
654[  660.889084] TCP bind hash table entries: 65536 (order: 9, 2359296 bytes)
655[  660.918941] TCP: Hash tables configured (established 131072 bind 65536)
656[  660.925169] TCP reno registered
657[  660.925287] UDP hash table entries: 512 (order: 3, 40960 bytes)
658[  660.925334] UDP-Lite hash table entries: 512 (order: 3, 40960 bytes)
659[  660.926992] NET: Registered protocol family 1
660[  660.926992] Trying to unpack rootfs image as initramfs...
661[  660.968988] Freeing initrd memory: 3712K
662[  660.996444] VFS: Disk quotas dquot_6.5.2
663[  660.996562] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
664[  660.996562] msgmni has been set to 1543
665[  661.001128] io scheduler noop registered
666[  661.001251] io scheduler deadline registered
667[  661.001300] io scheduler cfq registered (default)
668[  661.001427] start plist test
669[  661.006276] end plist test
670[  661.029079] Console: switching to colour frame buffer device 100x40
671[  661.038998] pxa2xx-uart.2: ttyS2 at MMIO 0xd4018000 (irq = 24) is a STUART
672[  661.544834] console [ttyS2] enabled
673[  661.549990] pxa2xx-uart.3: ttyS3 at MMIO 0xd4016000 (irq = 46) is a HWUART
674[  661.557947]
675[  661.557952] [galcore] registerBase =0xd420d000, registerMemSize = 0x0003ffff, contiguousBase= 0x30000000, contiguousSize = 0x03ffffff
676[  661.578958]
677[  661.582618] [galcore] real contiguouSize = 0x03ffffff
678[  661.600586]
679[  661.600611] [galcore] chipModel=0x860,chipRevision=0x4603,chipFeatures=0xe02c6eed,chipMinorFeatures=0xcbf99fff
680[  661.643633] brd: module loaded
681[  661.654271] lis3lv02d: unknown sensor type 0x87
682[  661.665052] lis3lv02d_i2c: probe of 5-001d failed with error -22
683[  661.677364] lis3lv02d: 16 bits sensor found
684[  661.749664] input: ST LIS3LV02DL Accelerometer as /devices/platform/lis3lv02d/input/input0
685[  661.764497] OLPC XO-1.75 Embedded Controller driver probed
686[  661.776929] input: Power Button as /devices/platform/olpc-ec-1.75.0/input/input1
687[  661.795529] OLPC board revision 1C1 (EC api 3)
688[  661.806262] input: OLPC OLS notify as /devices/platform/olpc-ols.0/input/input2
689[  661.821078] OLPC XO-1.75 lid and ebook switches
690[  661.831927] input: OLPC lid switch as /devices/virtual/input/input3
691[  661.845406] input: OLPC ebook switch as /devices/virtual/input/input4
692[  661.858955] usbcore: registered new interface driver ipheth
693[  661.871172] usbcore: registered new interface driver hwa-rc
694[  661.883364] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
695[  661.897081] pxa9xx_ehci_probe: ehci:ef7ced0c, ehci->regs=f5828140
696[  661.909582] pxau2o-ehci pxau2o-ehci.0: pxa9xx ehci
697[  661.923605] pxau2o-ehci pxau2o-ehci.0: new USB bus registered, assigned bus number 1
698[  661.938209] pxau2o-ehci pxau2o-ehci.0: irq 44, io mem 0xd4208000
699[  661.969002] pxau2o-ehci pxau2o-ehci.0: USB 2.0 started, EHCI 1.00
700[  661.982483] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
701[  661.995819] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
702[  662.009608] usb usb1: Product: pxa9xx ehci
703[  662.020275] usb usb1: Manufacturer: Linux 3.0.0_xo1.75-20111201.1013.olpc.8ab3406 ehci_hcd
704[  662.035287] usb usb1: SerialNumber: pxau2o-ehci.0
705[  662.049757] hub 1-0:1.0: USB hub found
706[  662.060145] hub 1-0:1.0: 1 port detected
707[  662.073158] usbcore: registered new interface driver wusb-cbaf
708[  662.085731] Initializing USB Mass Storage driver...
709[  662.096951] usbcore: registered new interface driver usb-storage
710[  662.109430] USB Mass Storage support registered.
711[  662.120320] usbcore: registered new interface driver libusual
712[  662.132961] usbcore: registered new interface driver mdc800
713[  662.144893] mdc800: v0.7.5 (30/10/2000):USB Driver for Mustek MDC800 Digital Camera
714[  662.158943] usbcore: registered new interface driver usbserial
715[  662.171680] USB Serial support registered for generic
716[  662.183278] usbcore: registered new interface driver usbserial_generic
717[  662.196250] usbserial: USB Serial Driver core
718[  662.211389] RAYDIUM_init
719[  662.220915] RAYDIUM_i2c_probe, i2c new style format
720[  662.231915] i2c-core: driver [raydium_ts] using legacy suspend method
721[  662.244541] i2c-core: driver [raydium_ts] using legacy resume method
722[  662.256815] RAYDIUM_i2c_register_device, add i2c device, success
723[  662.268731] RAYDIUM_i2c_register_device, client.addr: 0x30
724[  662.280138] RAYDIUM_i2c_register_device, client.adapter: 0xEE0AA860
725[  662.292717] RAYDIUM_i2c_register_device, client.driver: 0xC04EEA34
726[  662.326934] input: AT Translated Set 2 keyboard as /devices/platform/olpc-kbd.0/serio0/input/input5
727[  662.408965] usb 1-1: new high speed USB device number 2 using pxau2o-ehci
728[  662.570742] usb 1-1: New USB device found, idVendor=05e3, idProduct=0608
729[  662.583379] usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0
730[  662.596388] usb 1-1: Product: USB2.0 Hub
731[  662.607926] hub 1-1:1.0: USB hub found
732[  662.617980] hub 1-1:1.0: 4 ports detected
733[  664.338974] RAYDIUM_i2c_read, i2c read error, ret -121
734[  664.349985] input: raydium_ts as /devices/platform/pxa2xx-i2c.3/i2c-3/3-0030/input/input6
735[  664.364543] RAYDIUM_i2c_register_device, register input device, success
736[  664.377697] RAYDIUM_i2c_register_device, request irq, success
737[  664.389402] mmp-rtc mmp-rtc: rtc core: registered mmp-rtc as rtc0
738[  664.404294] rtc_idt1338 1-0068: rtc core: registered rtc_idt1338 as rtc1
739[  664.417383] lirc_dev: IR Remote Control driver registered, major 252
740[  664.430075] IR RC5 (streamzap) protocol handler initialized
741[  664.441698] IR LIRC bridge handler initialized
742[  664.452049] Linux video capture interface: v2.00
743[  664.619855] sdhci: Secure Digital Host Controller Interface driver
744[  664.632342] sdhci: Copyright(c) Pierre Ossman
745[  664.642656] mmc0: no vmmc regulator found
746[  664.654546] mmc0: SDHCI controller on MMC [sdhci-pxa.0] using DMA
747[  664.667165] mmc1: no vmmc regulator found
748[  664.677750] mmc1: SDHCI controller on MMC [sdhci-pxa.1] using DMA
749[  664.689966] mmc2: no vmmc regulator found
750[  664.700563] mmc2: SDHCI controller on MMC [sdhci-pxa.2] using DMA
751[  664.717363] usbcore: registered new interface driver usbhid
752[  664.729168] usbhid: USB HID core driver
753[  664.738953] i2c-core: driver [olpc_dcon] using legacy suspend method
754[  664.751359] i2c-core: driver [olpc_dcon] using legacy resume method
755[  664.766690] olpc-dcon:  Discovered DCON version 2
756[  664.798907] usbcore: registered new interface driver snd-usb-audio
757[  664.917644] asoc: alc5631-hifi <-> mmp2-i2s.0 mapping ok
758[  664.930274] input: OLPC XO-1.75 Headphone Jack as /devices/platform/soc-audio/sound/card0/input7
759[  664.949161] input: OLPC XO-1.75 Mic Jack as /devices/platform/soc-audio/sound/card0/input8
760[  664.963960] ALSA device list:
761[  664.975560]   #0: OLPC XO-1.75
762[  664.987434] TCP bic registered
763[  664.996495] Initializing XFRM netlink socket
764[  665.006607] NET: Registered protocol family 10
765[  665.019371] NET: Registered protocol family 17
766[  665.029748] lib80211: common routines for IEEE802.11 drivers
767[  665.041736] Registering the dns_resolver key type
768[  665.052391] VFP support v0.3: implementor 56 architecture 2 part 20 variant 9 rev 5
769[  665.066792] ThumbEE CPU extension supported.
770[  665.077008] Registering SWP/SWPB emulation handler
771[  665.087727] PJ4 iWMMXt coprocessor enabled.
772[  665.097878] sram: allocated 4k from d1021000
773[  665.107896] initcall mmp2_pm_init+0x0/0x118 returned with preemption imbalance
774[  665.123699] rtc_idt1338 1-0068: setting system clock to 2000-01-04 06:32:50 UTC (946967570)
775[  665.139649] Freeing init memory: 144K
776[  665.181166] mmc1: new SDIO card at address 0001
777[  665.300772] udev[46]: starting version 161
778[  665.313970] mmc2: new high speed DDR MMC card at address 0001
779[  665.349830] mmcblk0: mmc2:0001 SEM08G 7.39 GiB
780[  665.379340] mmcblk0boot0: mmc2:0001 SEM08G partition 1 1.00 MiB
781[  665.399553] mmcblk0boot1: mmc2:0001 SEM08G partition 2 1.00 MiB
782[  665.440080]  mmcblk0: p1 p2
783[  665.467418]  mmcblk0boot1: unknown partition table
784[  665.498916]  mmcblk0boot0: unknown partition table
785[  667.692512] EXT4-fs (mmcblk0p2): couldn't mount as ext3 due to feature incompatibilities
786[  667.710604] EXT4-fs (mmcblk0p2): couldn't mount as ext2 due to feature incompatibilities
787[  667.741049] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
788[  667.770632] dracut: Mounted root filesystem /dev/disk/mmc/mmc2p2
789[  667.790221] EXT4-fs (mmcblk0p2): warning: maximal mount count reached, running e2fsck is recommended
790[  667.817381] EXT4-fs (mmcblk0p2): re-mounted. Opts: user_xattr,acl,barrier=1,data=ordered
791[  667.846667] EXT4-fs (mmcblk0p1): couldn't mount as ext3 due to feature incompatibilities
792[  667.870035] EXT4-fs (mmcblk0p1): mounting ext2 file system using the ext4 subsystem
793[  667.888553] EXT4-fs (mmcblk0p1): warning: mounting unchecked fs, running e2fsck is recommended
794[  667.904507] EXT4-fs (mmcblk0p1): mounted filesystem without journal. Opts:
795[  668.422033] dcon_freeze_store: 0
796[  668.427995] dcon_source_switch to CPU
797[  668.461786] olpc-dcon: The CPU has control
798[  668.510706] EXT4-fs (mmcblk0p2): re-mounted. Opts: user_xattr,acl,barrier=1,data=ordered
799[  668.682333] dracut: Switching root
800[  669.517542] udev[199]: starting version 161
801[  670.569921] mousedev: PS/2 mouse device common for all mice
802[  671.085290] libertas_sdio: Libertas SDIO driver
803[  671.149252] Finger Sensing Pad, hw: 13.2.1, sw: 1.0.0-K, buttons: 4
804[  671.274792] psmouse serio1: Unable to set up required mode bits.
805[  671.291822]
806[  671.291833] =============================================
807[  671.298669] [ INFO: possible recursive locking detected ]
808[  671.298669] 3.0.0_xo1.75-20111201.1013.olpc.8ab3406 #1
809[  671.304030] ---------------------------------------------
810[  671.314488] kworker/0:1/12 is trying to acquire lock:
811[  671.314488]  (&ps2dev->cmd_mutex){+.+...}, at: [<c022eed0>] ps2_command+0x14/0x38
812[  671.326978]
813[  671.326982] but task is already holding lock:
814[  671.326982]  (&ps2dev->cmd_mutex){+.+...}, at: [<bf01c784>] fsp_reg_write+0x1c/0x158 [psmouse]
815[  671.341375]
816[  671.341380] other info that might help us debug this:
817[  671.347855]  Possible unsafe locking scenario:
818[  671.347855]
819[  671.353729]        CPU0
820[  671.353729]        ----
821[  671.358571]   lock(&ps2dev->cmd_mutex);
822[  671.358571]   lock(&ps2dev->cmd_mutex);
823[  671.362386]
824[  671.366208]  *** DEADLOCK ***
825[  671.366208]
826[  671.366214]  May be due to missing lock nesting notation
827[  671.372088]
828[  671.378820] 8 locks held by kworker/0:1/12:
829[  671.382970]  #0:  (events_long){.+.+.+}, at: [<c005af9c>] process_one_work+0x1f4/0x42c
830[  671.382970]  #1:  (serio_event_work){+.+.+.}, at: [<c005af9c>] process_one_work+0x1f4/0x42c
831[  671.390870]  #2:  (serio_mutex){+.+.+.}, at: [<c022df94>] serio_handle_event+0x14/0x1a8
832[  671.399192]  #3:  (&__lockdep_no_validate__){+.+.+.}, at: [<c01ce490>] __driver_attach+0x40/0x8c
833[  671.415933]  #4:  (&__lockdep_no_validate__){+.+.+.}, at: [<c01ce4a0>] __driver_attach+0x50/0x8c
834[  671.424694]  #5:  (&serio->drv_mutex){+.+.+.}, at: [<c022d838>] serio_driver_probe+0x20/0x44
835[  671.424694]  #6:  (psmouse_mutex){+.+.+.}, at: [<bf01a8ec>] psmouse_connect+0x18/0x280 [psmouse]
836[  671.441864]  #7:  (&ps2dev->cmd_mutex){+.+...}, at: [<bf01c784>] fsp_reg_write+0x1c/0x158 [psmouse]
837[  671.450884]
838[  671.450889] stack backtrace:
839[  671.455234] [<c0037ab8>] (unwind_backtrace+0x0/0x120) from [<c0073524>] (__lock_acquire+0x183c/0x18e0)
840[  671.464483] [<c0073524>] (__lock_acquire+0x183c/0x18e0) from [<c0073a84>] (lock_acquire+0x60/0x74)
841[  671.473395] [<c0073a84>] (lock_acquire+0x60/0x74) from [<c03847dc>] (mutex_lock_nested+0x44/0x314)
842[  671.482302] [<c03847dc>] (mutex_lock_nested+0x44/0x314) from [<c022eed0>] (ps2_command+0x14/0x38)
843[  671.482302] [<c022eed0>] (ps2_command+0x14/0x38) from [<bf01a60c>] (psmouse_extensions+0x100/0x23c [psmouse])
844[  671.501009] [<bf01a60c>] (psmouse_extensions+0x100/0x23c [psmouse]) from [<bf01a80c>] (psmouse_switch_protocol+0xc4/0x18c [psmouse])
845[  671.512869] [<bf01a80c>] (psmouse_switch_protocol+0xc4/0x18c [psmouse]) from [<bf01aa3c>] (psmouse_connect+0x168/0x280 [psmouse])
846[  671.524457] [<bf01aa3c>] (psmouse_connect+0x168/0x280 [psmouse]) from [<c022d848>] (serio_driver_probe+0x30/0x44)
847[  671.534657] [<c022d848>] (serio_driver_probe+0x30/0x44) from [<c01ce32c>] (driver_probe_device+0x144/0x268)
848[  671.544340] [<c01ce32c>] (driver_probe_device+0x144/0x268) from [<c01ce4b8>] (__driver_attach+0x68/0x8c)
849[  671.553766] [<c01ce4b8>] (__driver_attach+0x68/0x8c) from [<c01cd38c>] (bus_for_each_dev+0x4c/0x78)
850[  671.562759] [<c01cd38c>] (bus_for_each_dev+0x4c/0x78) from [<c022e098>] (serio_handle_event+0x118/0x1a8)
851[  671.562759] [<c022e098>] (serio_handle_event+0x118/0x1a8) from [<c005b020>] (process_one_work+0x278/0x42c)
852[  671.581784] [<c005b020>] (process_one_work+0x278/0x42c) from [<c005d0a4>] (worker_thread+0x1e0/0x2e4)
853[  671.581784] [<c005d0a4>] (worker_thread+0x1e0/0x2e4) from [<c0060acc>] (kthread+0x80/0x88)
854[  671.599172] [<c0060acc>] (kthread+0x80/0x88) from [<c0032fb8>] (kernel_thread_exit+0x0/0x8)
855[  671.703795] libertas_sdio: Copyright Pierre Ossman
856[  672.216067] ov7670 7-0021: chip found @ 0x42 (i2c-gpio7)
857[  672.399297] mmp-camera mmp-camera.0: Release, 0 frames, 0 singles, 0 delivered
858[  673.026563] libertas_sdio mmc1:0001:1: (unregistered net_device): 20:7c:8f:6d:7f:00, fw 9.70.3p36, cap 0x000003a3
859[  673.054872] libertas_sdio mmc1:0001:1: wlan0: Marvell WLAN 802.11 adapter
860[  673.099586] udev[202]: renamed network interface wlan0 to eth0