[BUG] gma500: sleeping function called from invalid context at kernel/mutex.c:413

Holger Schurig holgerschurig at gmail.com
Wed Nov 13 07:49:39 PST 2013


Kernel: 3.10.19

>From time to time, when I booted, I had a completely dark screen (with
kernel command line quiet) and a non-blinking cursor. I wondered if
that was perhaps gma500. So I turned on various debug checks. Then
I've got the BUG from the subject.

The device is a " VGA compatible controller [0300]: Intel Corporation
System Controller Hub (SCH Poulsbo) Graphics Controller [8086:8108]
(rev 07)".

Here's relevant "dmesg" output:

...
PCI: Using MMCONFIG for extended config space
PCI: Using host bridge windows from ACPI; if necessary, use
"pci=nocrs" and report a bug
[Firmware Bug]: ACPI: No _BQC method, cannot determine initial brightness
[Firmware Bug]: ACPI: No _BQC method, cannot determine initial brightness
ACPI: Power Resource [FAN1] (on)
...
gma500 0000:00:02.0: Backlight lvds set brightness 7a127a12
...
r8169 0000:02:00.0 eth0: link up
[Firmware Bug]: ACPI: No _BQC method, cannot determine initial brightness
acpi device:04: registered as cooling_device1
acpi device:05: registered as cooling_device2
ACPI: Video Device [GFX0] (multi-head: yes  rom: no  post: no)
input: Video Bus as
/devices/LNXSYSTM:00/device:00/PNP0A08:00/LNXVIDEO:00/input/input7
[drm] Supports vblank timestamp caching Rev 1 (10.10.2010).
[drm] No driver support for vblank timestamp query.
fbcon: psbdrmfb (fb0) is primary device
Console: switching to colour frame buffer device 100x37
gma500 0000:00:02.0: fb0: psbdrmfb frame buffer device
gma500 0000:00:02.0: registered panic notifier
gma500 0000:00:02.0: Backlight lvds set brightness 7a127a12
[drm] Initialized gma500 1.0.0 2011-06-06 for 0000:00:02.0 on minor 0
gma500 0000:00:02.0: Backlight lvds set brightness 7a127a12
BUG: sleeping function called from invalid context at kernel/mutex.c:413
in_atomic(): 1, irqs_disabled(): 1, pid: 310, name: Xorg
5 locks held by Xorg/310:
 #0:  (&fb_info->lock){+.+.+.}, at: [<c1195f17>] lock_fb_info+0x13/0x30
 #1:  (console_lock){+.+.+.}, at: [<c1196c7a>] do_fb_ioctl+0x3cf/0x44a
 #2:  ((fb_notifier_list).rwsem){++++.+}, at: [<c1049918>]
__blocking_notifier_call_chain+0x1e/0x4f
 #3:  (&new_bd->ops_lock){+.+...}, at: [<c11a2937>]
fb_notifier_callback+0x31/0xaa
 #4:  (&new_bd->update_lock){+.+...}, at: [<c11a2982>]
fb_notifier_callback+0x7c/0xaa
irq event stamp: 31266
hardirqs last  enabled at (31265): [<c12fd1ff>]
_raw_spin_unlock_irqrestore+0x33/0x56
hardirqs last disabled at (31266): [<c12fe2aa>] common_interrupt+0x2a/0x36
softirqs last  enabled at (30912): [<c102ee2f>] __do_softirq+0x1b1/0x208
softirqs last disabled at (30903): [<c1002dec>] do_softirq+0x54/0xa1
CPU: 0 PID: 310 Comm: Xorg Tainted: G           O 3.10.19 #1
 f615dfa0 f615dfa0 f6c09ebc c12f8f85 f6c09ee0 c104dad6 c13f7580 00000001
 00000001 00000136 f615e294 f5cc9818 f5cc9818 f6c09f30 c12faddc 00000001
 ca825490 f5018104 f6330004 f615e4ac f615dfa0 f615e4b4 f6c09f98 00003046
Call Trace:
 [<c12f8f85>] dump_stack+0x16/0x18
 [<c104dad6>] __might_sleep+0xf8/0xff
 [<c12faddc>] mutex_lock_nested+0x1e/0x317
 [<f86ee455>] do_gma_backlight_set+0x1d/0x3d [gma500_gfx]
 [<f86ee4ef>] gma_backlight_set+0x2a/0x2d [gma500_gfx]
 [<f86fa9b1>] psb_intel_opregion_asle_intr+0xc4/0xe0 [gma500_gfx]
 [<f86f9359>] psb_irq_handler+0x7e/0x176 [gma500_gfx]
 [<c107b1dc>] handle_irq_event_percpu+0x5a/0x1cf
 [<c107d4a9>] ? handle_fasteoi_irq+0x11/0x97
 [<c107b37d>] handle_irq_event+0x2c/0x43
 [<c107d498>] ? handle_level_irq+0x98/0x98
 [<c107d502>] handle_fasteoi_irq+0x6a/0x97
 <IRQ>  [<c1002c80>] ? do_IRQ+0x37/0x9a
 [<c11b8eab>] ? acpi_ex_store+0xb8/0x219
 [<c12fe2b1>] ? common_interrupt+0x31/0x36
 [<c11b00d8>] ? acpi_ds_load2_end_op+0x1e1/0x311
 [<c11b042e>] ? acpi_ds_result_push+0x29/0x13e
 [<c11aee7d>] ? acpi_ds_clear_operands+0x17/0x33
 [<c11af6e6>] ? acpi_ds_exec_end_op+0x27e/0x3b0
 [<c11c00b8>] ? acpi_ps_append_arg+0x19/0x7d
 [<c11bf3cc>] ? acpi_ps_parse_loop+0x4a4/0x4f0
 [<c10c6f02>] ? kfree+0xbb/0x13b
 [<c11bfd5f>] ? acpi_ps_parse_aml+0x82/0x23f
 [<c11c0482>] ? acpi_ps_execute_method+0x19c/0x23a
 [<c11bb6f3>] ? acpi_ns_evaluate+0xaf/0x194
 [<c11bdf18>] ? acpi_evaluate_object+0xf1/0x1e5
 [<c11c7d7e>] ? acpi_video_device_lcd_set_level+0x52/0xd3
 [<c11c7e57>] ? acpi_video_set_brightness+0x21/0x24
 [<c11a2995>] ? fb_notifier_callback+0x8f/0xaa
 [<c10497dc>] ? notifier_call_chain+0x25/0x46
 [<c1049933>] ? __blocking_notifier_call_chain+0x39/0x4f
 [<c1049963>] ? blocking_notifier_call_chain+0x1a/0x1c
 [<c1195bb5>] ? fb_notifier_call_chain+0x11/0x13
 [<c11960d6>] ? fb_blank+0x6a/0x73
 [<c1196c8e>] ? do_fb_ioctl+0x3e3/0x44a
 [<c106c5c7>] ? mark_held_locks+0xb3/0xd6
 [<c10b007b>] ? ftrace_raw_event_mm_page+0x85/0x90
 [<c1196cf5>] ? do_fb_ioctl+0x44a/0x44a
 [<c1196d15>] ? fb_ioctl+0x20/0x29
 [<c10da7eb>] ? vfs_ioctl+0x1b/0x25
 [<c10db157>] ? do_vfs_ioctl+0x413/0x451
 [<c10bdd69>] ? do_mmap_pgoff+0x24c/0x2bf
 [<c1048baa>] ? up_write+0x16/0x2b
 [<c10b07bd>] ? vm_mmap_pgoff+0x57/0x73
 [<c12fd68b>] ? restore_all+0xf/0xf
 [<c10db1d2>] ? SyS_ioctl+0x3d/0x5b
 [<c12fd658>] ? syscall_call+0x7/0xb
=================================
[ INFO: inconsistent lock state ]
3.10.19 #1 Tainted: G           O
---------------------------------
inconsistent {HARDIRQ-ON-W} -> {IN-HARDIRQ-W} usage.
Xorg/310 [HC1[1]:SC0[0]:HE0:SE1] takes:
 (&new_bd->update_lock){?.+...}, at: [<f86ee455>]
do_gma_backlight_set+0x1d/0x3d [gma500_gfx]
{HARDIRQ-ON-W} state was registered at:
  [<c106a9b7>] __lock_acquire+0x564/0x1664
  [<c106bf8e>] lock_acquire+0xbf/0xfa
  [<c12fae19>] mutex_lock_nested+0x5b/0x317
  [<f86f9e1b>] psb_backlight_init+0xf4/0x149 [gma500_gfx]
  [<f86ee508>] gma_backlight_init+0x16/0x18 [gma500_gfx]
  [<f86f2ef4>] psb_driver_load+0x37e/0x3c2 [gma500_gfx]
  [<f852677d>] drm_get_pci_dev+0x141/0x23a [drm]
  [<f86f29e4>] psb_probe+0xd/0xf [gma500_gfx]
  [<c1182d76>] pci_device_probe+0x59/0x91
  [<c11f6b39>] driver_probe_device+0x87/0x192
  [<c11f6c92>] __driver_attach+0x4e/0x6a
  [<c11f56b7>] bus_for_each_dev+0x3e/0x68
  [<c11f6786>] driver_attach+0x17/0x19
  [<c11f6432>] bus_add_driver+0xcd/0x1de
  [<c11f6fcb>] driver_register+0x7c/0xf4
  [<c1182e4f>] __pci_register_driver+0x45/0x48
  [<f85268ec>] drm_pci_init+0x76/0xd2 [drm]
  [<f8703012>] 0xf8703012
  [<c1000150>] do_one_initcall+0x7f/0x10f
  [<c107468b>] load_module+0x160a/0x18d2
  [<c10749bd>] SyS_init_module+0x6a/0x82
  [<c12fd658>] syscall_call+0x7/0xb
irq event stamp: 31266
hardirqs last  enabled at (31265): [<c12fd1ff>]
_raw_spin_unlock_irqrestore+0x33/0x56
hardirqs last disabled at (31266): [<c12fe2aa>] common_interrupt+0x2a/0x36
softirqs last  enabled at (30912): [<c102ee2f>] __do_softirq+0x1b1/0x208
softirqs last disabled at (30903): [<c1002dec>] do_softirq+0x54/0xa1

other info that might help us debug this:
 Possible unsafe locking scenario:

       CPU0
       ----
  lock(&new_bd->update_lock);
  <Interrupt>
    lock(&new_bd->update_lock);

 *** DEADLOCK ***

5 locks held by Xorg/310:
 #0:  (&fb_info->lock){+.+.+.}, at: [<c1195f17>] lock_fb_info+0x13/0x30
 #1:  (console_lock){+.+.+.}, at: [<c1196c7a>] do_fb_ioctl+0x3cf/0x44a
 #2:  ((fb_notifier_list).rwsem){++++.+}, at: [<c1049918>]
__blocking_notifier_call_chain+0x1e/0x4f
 #3:  (&new_bd->ops_lock){+.+...}, at: [<c11a2937>]
fb_notifier_callback+0x31/0xaa
 #4:  (&new_bd->update_lock){?.+...}, at: [<c11a2982>]
fb_notifier_callback+0x7c/0xaa

stack backtrace:
CPU: 0 PID: 310 Comm: Xorg Tainted: G           O 3.10.19 #1
 f615dfa0 f615dfa0 f6c09da8 c12f8f85 f6c09de4 c12f7561 c13f9d5d c13faa2a
 00000136 00000001 00000001 00000000 00000000 00000000 00000001 00000002
 00000000 f615e4b4 00000000 f6c09e18 c106a2a6 00000000 f6c09dfc c104332e
Call Trace:
 [<c12f8f85>] dump_stack+0x16/0x18
 [<c12f7561>] print_usage_bug.part.30+0x25d/0x265
 [<c106a2a6>] mark_lock+0x3c3/0x570
 [<c104332e>] ? __kernel_text_address+0x1d/0x39
 [<c1069635>] ? print_shortest_lock_dependencies+0x170/0x170
 [<c106a951>] __lock_acquire+0x4fe/0x1664
 [<c1002f79>] ? dump_trace+0x91/0xc5
 [<c1003d01>] ? show_trace_log_lvl+0x42/0x49
 [<c1003040>] ? show_stack_log_lvl+0x93/0x9b
 [<c106bf8e>] lock_acquire+0xbf/0xfa
 [<f86ee455>] ? do_gma_backlight_set+0x1d/0x3d [gma500_gfx]
 [<f86ee455>] ? do_gma_backlight_set+0x1d/0x3d [gma500_gfx]
 [<c12fae19>] mutex_lock_nested+0x5b/0x317
 [<f86ee455>] ? do_gma_backlight_set+0x1d/0x3d [gma500_gfx]
 [<f86ee455>] do_gma_backlight_set+0x1d/0x3d [gma500_gfx]
 [<f86ee4ef>] gma_backlight_set+0x2a/0x2d [gma500_gfx]
 [<f86fa9b1>] psb_intel_opregion_asle_intr+0xc4/0xe0 [gma500_gfx]
 [<f86f9359>] psb_irq_handler+0x7e/0x176 [gma500_gfx]
 [<c107b1dc>] handle_irq_event_percpu+0x5a/0x1cf
 [<c107d4a9>] ? handle_fasteoi_irq+0x11/0x97
 [<c107b37d>] handle_irq_event+0x2c/0x43
 [<c107d498>] ? handle_level_irq+0x98/0x98
 [<c107d502>] handle_fasteoi_irq+0x6a/0x97
 <IRQ>  [<c1002c80>] ? do_IRQ+0x37/0x9a
 [<c11b8eab>] ? acpi_ex_store+0xb8/0x219
 [<c12fe2b1>] ? common_interrupt+0x31/0x36
 [<c11b00d8>] ? acpi_ds_load2_end_op+0x1e1/0x311
 [<c11b042e>] ? acpi_ds_result_push+0x29/0x13e
 [<c11aee7d>] ? acpi_ds_clear_operands+0x17/0x33
 [<c11af6e6>] ? acpi_ds_exec_end_op+0x27e/0x3b0
 [<c11c00b8>] ? acpi_ps_append_arg+0x19/0x7d
 [<c11bf3cc>] ? acpi_ps_parse_loop+0x4a4/0x4f0
 [<c10c6f02>] ? kfree+0xbb/0x13b
 [<c11bfd5f>] ? acpi_ps_parse_aml+0x82/0x23f
 [<c11c0482>] ? acpi_ps_execute_method+0x19c/0x23a
 [<c11bb6f3>] ? acpi_ns_evaluate+0xaf/0x194
 [<c11bdf18>] ? acpi_evaluate_object+0xf1/0x1e5
 [<c11c7d7e>] ? acpi_video_device_lcd_set_level+0x52/0xd3
 [<c11c7e57>] ? acpi_video_set_brightness+0x21/0x24
 [<c11a2995>] ? fb_notifier_callback+0x8f/0xaa
 [<c10497dc>] ? notifier_call_chain+0x25/0x46
 [<c1049933>] ? __blocking_notifier_call_chain+0x39/0x4f
 [<c1049963>] ? blocking_notifier_call_chain+0x1a/0x1c
 [<c1195bb5>] ? fb_notifier_call_chain+0x11/0x13
 [<c11960d6>] ? fb_blank+0x6a/0x73
 [<c1196c8e>] ? do_fb_ioctl+0x3e3/0x44a
 [<c106c5c7>] ? mark_held_locks+0xb3/0xd6
 [<c10b007b>] ? ftrace_raw_event_mm_page+0x85/0x90
 [<c1196cf5>] ? do_fb_ioctl+0x44a/0x44a
 [<c1196d15>] ? fb_ioctl+0x20/0x29
 [<c10da7eb>] ? vfs_ioctl+0x1b/0x25
 [<c10db157>] ? do_vfs_ioctl+0x413/0x451
 [<c10bdd69>] ? do_mmap_pgoff+0x24c/0x2bf
 [<c1048baa>] ? up_write+0x16/0x2b
 [<c10b07bd>] ? vm_mmap_pgoff+0x57/0x73
 [<c12fd68b>] ? restore_all+0xf/0xf
 [<c10db1d2>] ? SyS_ioctl+0x3d/0x5b
 [<c12fd658>] ? syscall_call+0x7/0xb
gma500 0000:00:02.0: Backlight lvds set brightness 7a127a12
gma500 0000:00:02.0: Backlight lvds set brightness 7a127a12
gma500 0000:00:02.0: Backlight lvds set brightness 7a127a12
gma500 0000:00:02.0: Backlight lvds set brightness 7a127a12
gma500 0000:00:02.0: Backlight lvds set brightness 7a127a12
gma500 0000:00:02.0: Backlight lvds set brightness 7a127a12


More information about the dri-devel mailing list