Re: 2.6.24-rc5-mm1 -- inconsistent {in-hardirq-W} -> {hardirq-on-W}usage -- pm-hibernate/9940 [HC0[0]:SC0[0]:HE1:SE1]
From: Miles Lane
Date: Wed Dec 19 2007 - 10:07:15 EST
I discovered that I can use IMAP with GMail now, so I can send messages
using Thunderbird and avoid the line wrapping problem.
I tried doing a series: suspend-to-disk, suspend-to-ram and suspend-to-disk
Here is the result:
[ 11.827653] PM: Creating hibernation image:
[ 11.827658] WARNING: at arch/x86/kernel/smp_32.c:561
native_smp_call_function_mask()
[ 11.827661] Pid: 9940, comm: pm-hibernate Not tainted 2.6.24-rc5-mm1 #8
[ 11.827665] [<c0107d55>] show_trace_log_lvl+0x12/0x25
[ 11.827673] [<c010848a>] show_trace+0xd/0x10
[ 11.827677] [<c0108763>] dump_stack+0x57/0x5f
[ 11.827681] [<c0117db4>] native_smp_call_function_mask+0x41/0x126
[ 11.827686] [<c01192d9>] smp_call_function+0x18/0x1f
[ 11.827690] [<c012c624>] on_each_cpu+0x12/0x40
[ 11.827695] [<c0166ece>] drain_all_pages+0x13/0x16
[ 11.827700] [<c014f7b3>] swsusp_save+0x18/0x46b
[ 11.827705] [<c03103fa>] swsusp_arch_suspend+0x2a/0x2c
[ 11.827710] [<c014e7d8>] hibernate+0xba/0x16e
[ 11.827714] [<c014d56b>] state_store+0x45/0xac
[ 11.827717] [<c01ffe95>] kobj_attr_store+0x1a/0x22
[ 11.827722] [<c01b92c7>] sysfs_write_file+0xb8/0xe3
[ 11.827726] [<c01837eb>] vfs_write+0xa4/0x120
[ 11.827731] [<c0183d5e>] sys_write+0x3b/0x60
[ 11.827734] [<c0106bae>] sysenter_past_esp+0x6b/0xc1
[ 11.827738] =======================
[ 11.920363] PM: Need to copy 124108 pages
[ 11.920368] PM: Normal pages needed: 46468 + 1024 + 40, available
pages: 182806
[ 15.623893] PM: Hibernation image created (124108 pages copied)
[ 15.624618] Intel machine check architecture supported.
[ 15.624625] Intel machine check reporting enabled on CPU#0.
[ 15.624992]
[ 15.624993] =================================
[ 15.624995] [ INFO: inconsistent lock state ]
[ 15.624998] 2.6.24-rc5-mm1 #8
[ 15.624999] ---------------------------------
[ 15.625001] inconsistent {in-hardirq-W} -> {hardirq-on-W} usage.
[ 15.625005] pm-hibernate/9940 [HC0[0]:SC0[0]:HE1:SE1] takes:
[ 15.625007] (&cpu_base->lock_key){++..}, at: [<c013c453>]
retrigger_next_event+0x63/0x9f
[ 15.625017] {in-hardirq-W} state was registered at:
[ 15.625019] [<c0145432>] __lock_acquire+0x408/0xbf4
[ 15.625025] [<c0145c94>] lock_acquire+0x76/0x9d
[ 15.625029] [<c039aa08>] _spin_lock+0x19/0x28
[ 15.625035] [<c013cd92>] hrtimer_interrupt+0x72/0x1b0
[ 15.625039] [<c011a2b7>] smp_apic_timer_interrupt+0x69/0x7c
[ 15.625045] [<c0107777>] apic_timer_interrupt+0x33/0x38
[ 15.625050] [<c01054b5>] mwait_idle+0x1b/0x1d
[ 15.625054] [<c01055e9>] cpu_idle+0xb3/0xd4
[ 15.625058] [<c03986c5>] rest_init+0x49/0x4b
[ 15.625062] [<c04f696d>] start_kernel+0x357/0x35f
[ 15.625069] [<00000000>] 0x0
[ 15.625082] [<ffffffff>] 0xffffffff
[ 15.625087] irq event stamp: 1182359
[ 15.625089] hardirqs last enabled at (1182359): [<c0106cb3>]
restore_nocheck+0x12/0x15
[ 15.625094] hardirqs last disabled at (1182358): [<c010776d>]
apic_timer_interrupt+0x29/0x38
[ 15.625098] softirqs last enabled at (933018): [<c0137d89>]
__rcu_offline_cpu+0x32/0x62
[ 15.625104] softirqs last disabled at (933016): [<c039aa22>]
_spin_lock_bh+0xb/0x2d
[ 15.625109]
[ 15.625110] other info that might help us debug this:
[ 15.625112] 2 locks held by pm-hibernate/9940:
[ 15.625114] #0: (&buffer->mutex){--..}, at: [<c01b9234>]
sysfs_write_file+0x25/0xe3
[ 15.625121] #1: (pm_mutex){--..}, at: [<c014e72e>] hibernate+0x10/0x16e
[ 15.625127]
[ 15.625128] stack backtrace:
[ 15.625131] Pid: 9940, comm: pm-hibernate Not tainted 2.6.24-rc5-mm1 #8
[ 15.625133] [<c0107d55>] show_trace_log_lvl+0x12/0x25
[ 15.625138] [<c010848a>] show_trace+0xd/0x10
[ 15.625141] [<c0108763>] dump_stack+0x57/0x5f
[ 15.625144] [<c0143e45>] print_usage_bug+0x10a/0x117
[ 15.625148] [<c01447de>] mark_lock+0x1e7/0x3fe
[ 15.625152] [<c014549f>] __lock_acquire+0x475/0xbf4
[ 15.625156] [<c0145c94>] lock_acquire+0x76/0x9d
[ 15.625159] [<c039aa08>] _spin_lock+0x19/0x28
[ 15.625163] [<c013c453>] retrigger_next_event+0x63/0x9f
[ 15.625167] [<c013caf7>] hres_timers_resume+0x4d/0x4f
[ 15.625170] [<c013eed1>] timekeeping_resume+0x117/0x11e
[ 15.625175] [<c027b2ba>] __sysdev_resume+0x14/0x34
[ 15.625179] [<c027b752>] sysdev_resume+0x21/0x57
[ 15.625183] [<c027f426>] device_power_up+0x8/0xf
[ 15.625188] [<c014e6e7>] hibernation_snapshot+0x13c/0x173
[ 15.625192] [<c014e7d8>] hibernate+0xba/0x16e
[ 15.625195] [<c014d56b>] state_store+0x45/0xac
[ 15.625199] [<c01ffe95>] kobj_attr_store+0x1a/0x22
[ 15.625203] [<c01b92c7>] sysfs_write_file+0xb8/0xe3
[ 15.625207] [<c01837eb>] vfs_write+0xa4/0x120
[ 15.625211] [<c0183d5e>] sys_write+0x3b/0x60
[ 15.625214] [<c0106bae>] sysenter_past_esp+0x6b/0xc1
[ 15.625217] =======================
[ 15.625242] agpgart-intel 0000:00:00.0: EARLY resume
...
[ 15.624618] Intel machine check architecture supported.
[ 15.624625] Intel machine check reporting enabled on CPU#0.
[ 15.624992]
[ 15.624993] =================================
[ 15.624995] [ INFO: inconsistent lock state ]
[ 15.624998] 2.6.24-rc5-mm1 #8
[ 15.624999] ---------------------------------
[ 15.625001] inconsistent {in-hardirq-W} -> {hardirq-on-W} usage.
[ 15.625005] pm-hibernate/9940 [HC0[0]:SC0[0]:HE1:SE1] takes:
[ 15.625007] (&cpu_base->lock_key){++..}, at: [<c013c453>]
retrigger_next_event+0x63/0x9f
[ 15.625017] {in-hardirq-W} state was registered at:
[ 15.625019] [<c0145432>] __lock_acquire+0x408/0xbf4
[ 15.625025] [<c0145c94>] lock_acquire+0x76/0x9d
[ 15.625029] [<c039aa08>] _spin_lock+0x19/0x28
[ 15.625035] [<c013cd92>] hrtimer_interrupt+0x72/0x1b0
[ 15.625039] [<c011a2b7>] smp_apic_timer_interrupt+0x69/0x7c
[ 15.625045] [<c0107777>] apic_timer_interrupt+0x33/0x38
[ 15.625050] [<c01054b5>] mwait_idle+0x1b/0x1d
[ 15.625054] [<c01055e9>] cpu_idle+0xb3/0xd4
[ 15.625058] [<c03986c5>] rest_init+0x49/0x4b
[ 15.625062] [<c04f696d>] start_kernel+0x357/0x35f
[ 15.625069] [<00000000>] 0x0
[ 15.625082] [<ffffffff>] 0xffffffff
[ 15.625087] irq event stamp: 1182359
[ 15.625089] hardirqs last enabled at (1182359): [<c0106cb3>]
restore_nocheck+0x12/0x15
[ 15.625094] hardirqs last disabled at (1182358): [<c010776d>]
apic_timer_interrupt+0x29/0x38
[ 15.625098] softirqs last enabled at (933018): [<c0137d89>]
__rcu_offline_cpu+0x32/0x62
[ 15.625104] softirqs last disabled at (933016): [<c039aa22>]
_spin_lock_bh+0xb/0x2d
[ 15.625109]
[ 15.625110] other info that might help us debug this:
[ 15.625112] 2 locks held by pm-hibernate/9940:
[ 15.625114] #0: (&buffer->mutex){--..}, at: [<c01b9234>]
sysfs_write_file+0x25/0xe3
[ 15.625121] #1: (pm_mutex){--..}, at: [<c014e72e>] hibernate+0x10/0x16e
[ 15.625127]
[ 15.625128] stack backtrace:
[ 15.625131] Pid: 9940, comm: pm-hibernate Not tainted 2.6.24-rc5-mm1 #8
[ 15.625133] [<c0107d55>] show_trace_log_lvl+0x12/0x25
[ 15.625138] [<c010848a>] show_trace+0xd/0x10
[ 15.625141] [<c0108763>] dump_stack+0x57/0x5f
[ 15.625144] [<c0143e45>] print_usage_bug+0x10a/0x117
[ 15.625148] [<c01447de>] mark_lock+0x1e7/0x3fe
[ 15.625152] [<c014549f>] __lock_acquire+0x475/0xbf4
[ 15.625156] [<c0145c94>] lock_acquire+0x76/0x9d
[ 15.625159] [<c039aa08>] _spin_lock+0x19/0x28
[ 15.625163] [<c013c453>] retrigger_next_event+0x63/0x9f
[ 15.625167] [<c013caf7>] hres_timers_resume+0x4d/0x4f
[ 15.625170] [<c013eed1>] timekeeping_resume+0x117/0x11e
[ 15.625175] [<c027b2ba>] __sysdev_resume+0x14/0x34
[ 15.625179] [<c027b752>] sysdev_resume+0x21/0x57
[ 15.625183] [<c027f426>] device_power_up+0x8/0xf
[ 15.625188] [<c014e6e7>] hibernation_snapshot+0x13c/0x173
[ 15.625192] [<c014e7d8>] hibernate+0xba/0x16e
[ 15.625195] [<c014d56b>] state_store+0x45/0xac
[ 15.625199] [<c01ffe95>] kobj_attr_store+0x1a/0x22
[ 15.625203] [<c01b92c7>] sysfs_write_file+0xb8/0xe3
[ 15.625207] [<c01837eb>] vfs_write+0xa4/0x120
[ 15.625211] [<c0183d5e>] sys_write+0x3b/0x60
[ 15.625214] [<c0106bae>] sysenter_past_esp+0x6b/0xc1
[ 15.625217] =======================
[ 15.625242] agpgart-intel 0000:00:00.0: EARLY resume
--
To unsubscribe from this list: send the line "unsubscribe linux-kernel" in
the body of a message to majordomo@xxxxxxxxxxxxxxx
More majordomo info at http://vger.kernel.org/majordomo-info.html
Please read the FAQ at http://www.tux.org/lkml/