dmesg log

X_lockup (text/plain), 13.44 KB, created by Markos Chandras (RETIRED) on 2009-03-12 22:14:40 UTC

[    6.580767] Marking TSC unstable due to TSC halts in idle
[    6.596305] usbcore: registered new interface driver hiddev
[    6.606296] usbcore: registered new interface driver usbhid
[    6.615910] usbhid: v2.6:USB HID core driver
[    6.625741] Advanced Linux Sound Architecture Driver Version 1.0.18rc3.
[    6.635948] ALSA device list:
[    6.645680]   No soundcards found.
[    6.657969] TCP bic registered
[    6.667418] NET: Registered protocol family 17
[    6.676941] Bluetooth: L2CAP ver 2.11
[    6.686249] Bluetooth: L2CAP socket layer initialized
[    6.695562] Bluetooth: SCO (Voice Link) ver 0.6
[    6.704664] Bluetooth: SCO socket layer initialized
[    6.713712] Bluetooth: RFCOMM socket layer initialized
[    6.722553] Bluetooth: RFCOMM TTY layer initialized
[    6.731268] Bluetooth: RFCOMM ver 1.10
[    6.740092] Bluetooth: BNEP (Ethernet Emulation) ver 1.3
[    6.749078] Bluetooth: BNEP filters: protocol multicast
[    6.758221] Bluetooth: HIDP (Human Interface Emulation) ver 1.2
[    6.767715] usb 4-1: configuration #1 chosen from 1 choice
[    6.777559] RPC: Registered udp transport module.
[    6.786578] RPC: Registered tcp transport module.
[    6.817816] input: USB Optical Mouse USB Optical Mouse as /class/input/input5
[    6.827991] registered taskstats version 1
[    6.837413] rtc_cmos 00:06: setting system clock to 2009-03-12 22:00:20 UTC (1236895220)
[    6.900394] a4tech 0003:09DA:0006.0001: input: USB HID v1.10 Mouse [USB Optical Mouse USB Optical Mouse] on usb-0000:00:1a.1-1/input0
[    6.955552] EXT3-fs: INFO: recovery required on readonly filesystem.
[    6.965430] EXT3-fs: write access will be enabled during recovery.
[    7.002574] Clocksource tsc unstable (delta = -79697379 ns)
[    7.956123] kjournald starting.  Commit interval 5 seconds
[    7.966042] EXT3-fs: sda5: orphan cleanup on readonly fs
[    7.975853] ext3_orphan_cleanup: deleting unreferenced inode 450589
[    7.976207] ext3_orphan_cleanup: deleting unreferenced inode 450577
[    7.976232] ext3_orphan_cleanup: deleting unreferenced inode 450598
[    7.976257] ext3_orphan_cleanup: deleting unreferenced inode 450595
[    7.976274] EXT3-fs: sda5: 4 orphan inodes deleted
[    7.985973] EXT3-fs: recovery complete.
[    8.000452] EXT3-fs: mounted filesystem with ordered data mode.
[    8.010126] VFS: Mounted root (ext3 filesystem) readonly.
[    8.019713] Freeing unused kernel memory: 1988k freed
[    8.030152] Write protecting the kernel read-only data: 9664k
[    8.117323] Failed to execute /sbin/bootchartd.  Attempting defaults...
[   11.918196] ACPI: AC Adapter [ACAD] (on-line)
[   11.935553] acpi device:04: registered as cooling_device2
[   11.936532] input: Video Bus as /class/input/input6
[   12.025677] iTCO_vendor_support: vendor-support=0
[   12.030374] ACPI: Video Device [GFX0] (multi-head: yes  rom: no  post: no)
[   12.038163] iTCO_wdt: Intel TCO WatchDog Timer Driver v1.05
[   12.038449] iTCO_wdt: Found a ICH8M TCO device (Version=2, TCOBASE=0x1060)
[   12.038683] iTCO_wdt: initialized. heartbeat=30 sec (nowayout=0)
[   12.050331] HDA Intel 0000:00:1b.0: PCI INT A -> GSI 22 (level, low) -> IRQ 22
[   12.050444] HDA Intel 0000:00:1b.0: setting latency timer to 64
[   12.112490] input: PC Speaker as /class/input/input7
[   12.182084] sdhci: Secure Digital Host Controller Interface driver
[   12.182088] sdhci: Copyright(c) Pierre Ossman
[   12.194922] ohci1394 0000:0a:01.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[   12.225901] i801_smbus 0000:00:1f.3: PCI INT C -> GSI 19 (level, low) -> IRQ 19
[   12.225909] ACPI: I/O resource 0000:00:1f.3 [0x1c20-0x1c3f] conflicts with ACPI region SMBI [0x1c20-0x1c2f]
[   12.225912] ACPI: Device needs an ACPI driver
[   12.251035] ohci1394: fw-host0: OHCI-1394 1.1 (PCI): IRQ=[16]  MMIO=[f0400000-f04007ff]  Max Packet=[2048]  IR/IT contexts=[4/4]
[   12.259581] sdhci-pci 0000:0a:01.1: SDHCI controller found [1180:0822] (rev 22)
[   12.259610] sdhci-pci 0000:0a:01.1: PCI INT B -> GSI 17 (level, low) -> IRQ 17
[   12.260797] sdhci-pci 0000:0a:01.1: Will use DMA mode even though HW doesn't fully claim to support it.
[   12.262137] Registered led device: mmc0
[   12.263350] mmc0: SDHCI controller on PCI [0000:0a:01.1] using DMA
[   12.371694] ACPI: Battery Slot [BAT1] (battery present)
[   12.834634] Synaptics Touchpad, model: 1, fw: 6.5, id: 0x81c0b1, caps: 0xa04711/0xa00000
[   12.869821] input: SynPS/2 Synaptics TouchPad as /class/input/input8
[   13.571512] EXT3 FS on sda5, internal journal
[   13.573041] ieee1394: Host added: ID:BUS[0-00:1023]  GUID[001b240000aacb36]
[   13.902778] EXT4-fs: barriers enabled
[   14.550214] kjournald2 starting.  Commit interval 5 seconds
[   14.550902] EXT4 FS on sda7, internal journal on sda7:8
[   14.550908] EXT4-fs: delayed allocation enabled
[   14.550912] EXT4-fs: file extents enabled
[   14.559149] EXT4-fs: mballoc enabled
[   14.559151] EXT4-fs: recovery complete.
[   14.559769] EXT4-fs: mounted filesystem with ordered data mode.
[   14.599665] EXT4-fs: barriers enabled
[   15.007654] kjournald2 starting.  Commit interval 5 seconds
[   15.007906] EXT4 FS on sda3, internal journal on sda3:8
[   15.007912] EXT4-fs: delayed allocation enabled
[   15.007917] EXT4-fs: file extents enabled
[   15.010457] EXT4-fs: mballoc enabled
[   15.010459] EXT4-fs: recovery complete.
[   15.010845] EXT4-fs: mounted filesystem with ordered data mode.
[   15.054733] ReiserFS: sda6: found reiserfs format "3.6" with standard journal
[   15.054797] ReiserFS: sda6: using ordered data mode
[   15.063813] ReiserFS: sda6: journal params: device sda6, size 8192, journal first block 18, max trans len 1024, max batch 900, max commit age 30, max trans age 30
[   15.064432] ReiserFS: sda6: checking transaction log (sda6)
[   15.154331] ReiserFS: sda6: replayed 7 transactions in 0 seconds
[   15.198483] ReiserFS: sda6: Using r5 hash to sort names
[   20.935009] Adding 1959920k swap on /dev/sda2.  Priority:-1 extents:1 across:1959920k
[   22.187198] iwlagn 0000:04:00.0: PCI INT A -> GSI 18 (level, low) -> IRQ 18
[   22.187322] iwlagn 0000:04:00.0: restoring config space at offset 0x1 (was 0x100002, writing 0x100006)
[   22.187507] iwlagn 0000:04:00.0: irq 313 for MSI/MSI-X
[   22.187734] iwlagn 0000:04:00.0: firmware: requesting iwlwifi-4965-2.ucode
[   22.475704] Registered led device: iwl-phy0:radio
[   22.475801] Registered led device: iwl-phy0:assoc
[   22.475892] Registered led device: iwl-phy0:RX
[   22.475986] Registered led device: iwl-phy0:TX
[   24.327457] [drm] Initialized drm 1.1.0 20060810
[   24.353375] pci 0000:00:02.0: setting latency timer to 64
[   24.353718] pci 0000:00:02.0: irq 312 for MSI/MSI-X
[   24.354267] [drm] Initialized i915 1.6.0 20080730 on minor 0
[   24.355814] [drm:i915_setparam] *ERROR* unknown parameter 4
[   24.369420] BUG: using smp_processor_id() in preemptible [00000000] code: X/3640
[   24.369429] caller is paravirt_get_lazy_mode+0x1a/0x2c
[   24.369433] Pid: 3640, comm: X Not tainted 2.6.28-gentoo-r3-evil-inside #2
[   24.369436] Call Trace:
[   24.369442]  [<ffffffff8131ad17>] debug_smp_processor_id+0xd3/0xe8
[   24.369447]  [<ffffffff8103d709>] paravirt_get_lazy_mode+0x1a/0x2c
[   24.369452]  [<ffffffff81043337>] change_page_attr_set_clr+0x2f7/0x319
[   24.369457]  [<ffffffff8104375d>] set_memory_array_uc+0xa4/0x10f
[   24.369463]  [<ffffffff81344bf0>] ? agp_alloc_page_array+0x3f/0x4c
[   24.369468]  [<ffffffff81343dce>] agp_generic_alloc_pages+0xb2/0xec
[   24.369473]  [<ffffffff81344e45>] agp_allocate_memory+0xa4/0x107
[   24.369478]  [<ffffffff81342dea>] agp_allocate_memory_wrap+0x18/0x47
[   24.369482]  [<ffffffff813434cd>] agp_ioctl+0x34b/0x476
[   24.369488]  [<ffffffff8107a0a9>] ? trace_hardirqs_on+0xd/0xf
[   24.369505]  [<ffffffffa0138d7f>] ? drm_ioctl+0x218/0x267 [drm]
[   24.369509]  [<ffffffff81077efc>] ? get_lock_stats+0x2d/0x5d
[   24.369514]  [<ffffffff8131a737>] ? _raw_spin_unlock+0x8e/0x94
[   24.369519]  [<ffffffff810d9334>] vfs_ioctl+0x2a/0x78
[   24.369522]  [<ffffffff810d9704>] do_vfs_ioctl+0x382/0x3b0
[   24.369528]  [<ffffffff81025a7a>] ? sysret_check+0x46/0x81
[   24.369532]  [<ffffffff810d9787>] sys_ioctl+0x55/0x77
[   24.369537]  [<ffffffff81025a2a>] system_call_fastpath+0x16/0x1b
[   25.533907] X:3640 conflicting memory types d0000000-e0000000 write-combining<->uncached-minus
[   25.533912] reserve_memtype failed 0xd0000000-0xe0000000, track write-combining, req write-combining
[   26.346282] wlan0: authenticate with AP 00:1a:2a:8a:0c:13
[   26.349481] wlan0: authenticated
[   26.349487] wlan0: associate with AP 00:1a:2a:8a:0c:13
[   26.353432] wlan0: authenticate with AP 00:1a:2a:8a:0c:13
[   26.355863] wlan0: authenticated
[   26.355867] wlan0: associate with AP 00:1a:2a:8a:0c:13
[   26.360391] wlan0: RX AssocResp from 00:1a:2a:8a:0c:13 (capab=0x471 status=0 aid=3)
[   26.360395] wlan0: associated
[   26.567670] X:3640 conflicting memory types d0000000-e0000000 write-combining<->uncached-minus
[   26.567675] reserve_memtype failed 0xd0000000-0xe0000000, track write-combining, req write-combining
[   26.783431] X:3640 conflicting memory types d0000000-e0000000 write-combining<->uncached-minus
[   26.783436] reserve_memtype failed 0xd0000000-0xe0000000, track write-combining, req write-combining
[   26.800815] X:3921 freeing invalid memtype d0000000-e0000000
[   32.513030] NET: Registered protocol family 10
[   32.516535] lo: Disabled Privacy Extensions
[   43.222563] wlan0: no IPv6 routers present
[   51.418778] X:3640 conflicting memory types d0000000-e0000000 write-combining<->uncached-minus
[   51.418786] reserve_memtype failed 0xd0000000-0xe0000000, track write-combining, req write-combining
[   51.449641] X:3640 freeing invalid memtype d0000000-e0000000
[   51.466895] X:3640 conflicting memory types d0000000-e0000000 write-combining<->uncached-minus
[   51.466903] reserve_memtype failed 0xd0000000-0xe0000000, track write-combining, req write-combining
[   51.497773] X:3640 freeing invalid memtype d0000000-e0000000
[   51.515605] X:3640 conflicting memory types d0000000-e0000000 write-combining<->uncached-minus
[   51.515613] reserve_memtype failed 0xd0000000-0xe0000000, track write-combining, req write-combining
[   51.546639] X:4346 freeing invalid memtype d0000000-e0000000
[ 7270.112899] X:3640 freeing invalid memtype d0000000-e0000000
[ 7270.968559] X:3640 conflicting memory types d0000000-e0000000 uncached-minus<->write-combining
[ 7270.968566] reserve_memtype failed 0xd0000000-0xe0000000, track uncached-minus, req write-combining
[ 7271.668443] BUG: unable to handle kernel paging request at 0000000002002010
[ 7271.668452] IP: [<ffffffffa01574d8>] i915_gem_execbuffer+0x493/0xb55 [i915]
[ 7271.668467] PGD 79144067 PUD 79d5e067 PMD 0 
[ 7271.668474] Oops: 0002 [#1] PREEMPT SMP 
[ 7271.668480] last sysfs file: /sys/class/backlight/acpi_video0/brightness
[ 7271.668484] CPU 1 
[ 7271.668487] Modules linked in: ipv6 i915 drm snd_seq_dummy snd_seq_oss snd_seq_midi_event snd_seq snd_seq_device joydev sdhci_pci ohci1394 sdhci psmouse ieee1394 mmc_core pcspkr i2c_i801 serio_raw snd_hda_intel iTCO_wdt iTCO_vendor_support snd_hwdep input_polldev battery video ac output
[ 7271.668527] Pid: 3640, comm: X Not tainted 2.6.28-gentoo-r3-evil-inside #2
[ 7271.668530] RIP: 0010:[<ffffffffa01574d8>]  [<ffffffffa01574d8>] i915_gem_execbuffer+0x493/0xb55 [i915]
[ 7271.668541] RSP: 0018:ffff880079155d18  EFLAGS: 00010202
[ 7271.668544] RAX: 0000000002002010 RBX: ffff8800739e54e0 RCX: 0000000001fc2000
[ 7271.668548] RDX: 0000000000000010 RSI: ffff88007845c000 RDI: ffff88007f2a6e00
[ 7271.668551] RBP: ffff880079155e18 R08: 0000000000000010 R09: 0000000000000000
[ 7271.668554] R10: ffff88004d5cfea0 R11: ffffffff8109e483 R12: ffff8800739324c0
[ 7271.668557] R13: ffff8800298e8dc0 R14: ffff88004d5cfea0 R15: 00000000094bb620
[ 7271.668560] FS:  00007ff859ff86f0(0000) GS:ffff88007f002b00(0000) knlGS:0000000000000000
[ 7271.668564] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[ 7271.668567] CR2: 0000000002002010 CR3: 00000000790fe000 CR4: 00000000000006e0
[ 7271.668570] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
[ 7271.668573] DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000400
[ 7271.668576] Process X (pid: 3640, threadinfo ffff880079154000, task ffff880079d1a1b0)
[ 7271.668579] Stack:
[ 7271.668581]  ffff880079155d48 ffffffff81077efc ffff880079d1a890 000000000000098c
[ 7271.668588]  ffff880079155d48 ffff880079181700 ffff88004d5cfe00 ffff88007ada3000
[ 7271.668595]  ffff88007ad8e758 ffff88007ada3058 ffff88005f0cab10 0000000000000001
[ 7271.668604] Call Trace:
[ 7271.668607]  [<ffffffff81077efc>] ? get_lock_stats+0x2d/0x5d
[ 7271.668614]  [<ffffffff810c9324>] ? __kmalloc+0xd7/0x10a
[ 7271.668620]  [<ffffffff8107a071>] ? trace_hardirqs_on_caller+0xfe/0x129
[ 7271.668626]  [<ffffffffa0138d43>] drm_ioctl+0x1dc/0x267 [drm]
[ 7271.668642]  [<ffffffffa0157045>] ? i915_gem_execbuffer+0x0/0xb55 [i915]
[ 7271.668652]  [<ffffffff810d9369>] vfs_ioctl+0x5f/0x78
[ 7271.668657]  [<ffffffff810d9704>] do_vfs_ioctl+0x382/0x3b0
[ 7271.668662]  [<ffffffff81314886>] ? __up_write+0x10f/0x11e
[ 7271.668668]  [<ffffffff81025a7a>] ? sysret_check+0x46/0x81
[ 7271.668674]  [<ffffffff810d9787>] sys_ioctl+0x55/0x77
[ 7271.668679]  [<ffffffff81025a2a>] system_call_fastpath+0x16/0x1b
[ 7271.668684] Code: 55 b8 8b 4d b4 03 56 38 03 4b 38 48 89 d0 48 8b b5 70 ff ff ff 48 25 00 f0 ff ff 81 e2 ff 0f 00 00 48 03 86 18 0f 00 00 48 01 d0 <89> 08 ba 20 00 00 00 8b 5b 38 48 8d 75 b0 48 89 5d c0 4c 89 ff 
[ 7271.668759] RIP  [<ffffffffa01574d8>] i915_gem_execbuffer+0x493/0xb55 [i915]
[ 7271.668769]  RSP <ffff880079155d18>
[ 7271.668771] CR2: 0000000002002010
[ 7271.668774] ---[ end trace 802a134aa15d01e0 ]---