From mboxrd@z Thu Jan 1 00:00:00 1970 Return-Path: Received: (majordomo@vger.kernel.org) by vger.kernel.org via listexpand id S1754524Ab2LKTVf (ORCPT ); Tue, 11 Dec 2012 14:21:35 -0500 Received: from mx1.redhat.com ([209.132.183.28]:40080 "EHLO mx1.redhat.com" rhost-flags-OK-OK-OK-OK) by vger.kernel.org with ESMTP id S1753352Ab2LKTVe (ORCPT ); Tue, 11 Dec 2012 14:21:34 -0500 Date: Tue, 11 Dec 2012 14:21:25 -0500 From: Don Zickus To: Dave Jones , Linux Kernel Cc: tglx@linutronix.de Subject: Re: 3.7 watchdog debugobjects warning Message-ID: <20121211192125.GJ53431@redhat.com> References: <20121211184256.GA22068@redhat.com> MIME-Version: 1.0 Content-Type: text/plain; charset=us-ascii Content-Disposition: inline In-Reply-To: <20121211184256.GA22068@redhat.com> User-Agent: Mutt/1.5.21 (2010-09-15) Sender: linux-kernel-owner@vger.kernel.org List-ID: X-Mailing-List: linux-kernel@vger.kernel.org On Tue, Dec 11, 2012 at 01:42:56PM -0500, Dave Jones wrote: > Looks like we're doing a double-init on a timer. > > I had been experimenting with powertop, so that may have triggered something > maybe suspend/resume related ? Is this coming out of a resume then? I am not familiar with ODEBUG, so I can't really tell what it is complaining about. But it seems like the watchdog is being enabled which calls hrtimer_init to initialize a periodic event. It seems ODEBUG is complaining that isn't a good idea for some reason. Adding Thomas for his opinion. Cheers, Don > > (says -rc8, but it's only missing the Makefile change) > > [14844.560489] WARNING: at lib/debugobjects.c:261 debug_print_object+0x8c/0xb0() > [14844.560919] Hardware name: 2356JK8 > [14844.561133] ODEBUG: init active (active state 0) object type: hrtimer hint: watchdog_timer_fn+0x0/0x190 > [14844.561689] Modules linked in: bluetooth cpufreq_stats iptable_mangle nf_conntrack_ipv4 nf_defrag_ipv4 xt_conntrack nf_conntrack dm_crypt xfs arc4 iwldvm coretemp kvm_intel mac80211 kvm snd_hda_codec_hdmi snd_hda_codec_realtek snd_hda_intel snd_hda_codec crc32c_intel iTCO_wdt iTCO_vendor_support snd_hwdep ghash_clmulni_intel snd_seq iwlwifi microcode snd_seq_device pcspkr i2c_i801 snd_pcm cfg80211 tpm_tis e1000e thinkpad_acpi snd_page_alloc lpc_ich snd_timer mfd_core snd soundcore tpm tpm_bios nfsd auth_rpcgss nfs_acl lockd sunrpc btrfs libcrc32c zlib_deflate i915 i2c_algo_bit drm_kms_helper drm i2c_core video > [14844.565462] Pid: 14, comm: watchdog/0 Not tainted 3.7.0-rc8+ #4 > [14844.565818] Call Trace: > [14844.565978] [] warn_slowpath_common+0x7f/0xc0 > [14844.566342] [] warn_slowpath_fmt+0x46/0x50 > [14844.566690] [] debug_print_object+0x8c/0xb0 > [14844.567039] [] ? watchdog+0x30/0x30 > [14844.567353] [] __debug_object_init+0x20f/0x3e0 > [14844.567721] [] ? __schedule+0x479/0xa00 > [14844.568055] [] debug_object_init+0x1b/0x20 > [14844.568406] [] hrtimer_init+0x32/0x180 > [14844.568735] [] watchdog_enable+0x85/0x200 > [14844.569078] [] ? get_parent_ip+0x11/0x50 > [14844.569416] [] smpboot_thread_fn+0x10c/0x300 > [14844.569771] [] ? __smpboot_create_thread.part.2+0xc0/0xc0 > [14844.570193] [] kthread+0xed/0x100 > [14844.570496] [] ? wait_for_common+0x135/0x180 > [14844.570850] [] ? kthread_create_on_node+0x160/0x160 > [14844.571243] [] ret_from_fork+0x7c/0xb0 > [14844.571570] [] ? kthread_create_on_node+0x160/0x160 > [14844.571960] ---[ end trace 482f8371e46ff84f ]--- > > > Sidenote: At this point, the output in dmesg goes crazy. Would adding some KERN_CONT's > have fixed this ? > > > > [14844.572807] ------------[ cut here ]------------ > [14844.573099] WARNING: at lib/debugobjects.c:261 debug_print_object+0x8c/0xb0() > [14844.573529] Hardware name: 2356JK8 > [14844.573751] ODEBUG: init active (active state 0) object type: hrtimer hint: watchdog_timer_fn+0x0/0x190 > [14844.576953] ------------[ cut here ]------------ > [14844.576958] WARNING: at lib/debugobjects.c:261 debug_print_object+0x8c/0xb0() > [14844.576959] Hardware name: 2356JK8 > [14844.576962] ODEBUG: init active (active state 0) object type: hrtimer hint: watchdog_timer_fn+0x0/0x190 > [14844.574316] Modules linked in: bluetooth cpufreq_stats iptable_mangle nf_conntrack_ipv4 nf_defrag_ipv4 xt_conntrack nf_conntrack dm_crypt xfs arc4 iwldvm coretemp kvm_intel mac80211 kvm snd_hda_codec_hdmi snd_hda_codec_realtek snd_hda_intel snd_hda_codec crc32c_intel iTCO_wdt iTCO_vendor_support snd_hwdep ghash_clmulni_intel snd_seq iwlwifi microcode snd_seq_device pcspkr i2c_i801 snd_pcm cfg80211 tpm_tis e1000e thinkpad_acpi snd_page_alloc lpc_ich snd_timer mfd_core > [14844.576962] Modules linked in: > [14844.576963] bluetooth > [14844.576964] cpufreq_stats > [14844.576964] iptable_mangle > [14844.576965] nf_conntrack_ipv4 > [14844.576966] nf_defrag_ipv4 > [14844.576966] xt_conntrack > [14844.576967] nf_conntrack > [14844.576968] dm_crypt > [14844.576968] xfs > [14844.576969] arc4 > [14844.576969] iwldvm > [14844.576970] coretemp > [14844.576971] kvm_intel > [14844.576971] mac80211 > [14844.576972] kvm > [14844.576972] snd_hda_codec_hdmi > [14844.576973] snd_hda_codec_realtek > [14844.576974] snd_hda_intel > [14844.576974] snd_hda_codec > [14844.576975] crc32c_intel > [14844.576975] iTCO_wdt > [14844.576976] iTCO_vendor_support > [14844.576977] snd_hwdep > [14844.576977] ghash_clmulni_intel > [14844.576978] snd_seq > [14844.576978] iwlwifi > [14844.576979] microcode > [14844.576980] snd_seq_device > [14844.576980] pcspkr > [14844.576981] i2c_i801 > [14844.576981] snd_pcm > [14844.576982] cfg80211 > [14844.576983] tpm_tis > [14844.576983] e1000e > [14844.576984] thinkpad_acpi > [14844.576984] snd_page_alloc > [14844.576985] lpc_ich > [14844.576985] snd_timer > [14844.576986] mfd_core > [14844.576987] snd > [14844.576987] soundcore > [14844.576988] tpm > [14844.576989] tpm_bios > [14844.576989] nfsd > [14844.576990] auth_rpcgss > [14844.576990] nfs_acl > [14844.576991] lockd > [14844.576992] sunrpc > [14844.576992] btrfs > [14844.576993] libcrc32c > [14844.576994] zlib_deflate > [14844.576994] i915 > [14844.576995] i2c_algo_bit > [14844.576996] drm_kms_helper > [14844.576996] drm > [14844.576997] i2c_core > [14844.576998] video > > [14844.577000] Pid: 21, comm: watchdog/2 Tainted: G W 3.7.0-rc8+ #4 > [14844.577001] Call Trace: > > [14844.577005] [] warn_slowpath_common+0x7f/0xc0 > > [14844.577008] [] warn_slowpath_fmt+0x46/0x50 > > [14844.577011] [] debug_print_object+0x8c/0xb0 > > [14844.577013] [] ? watchdog+0x30/0x30 > > [14844.577015] [] __debug_object_init+0x20f/0x3e0 > > [14844.577018] [] ? __schedule+0x479/0xa00 > [14844.577018] ------------[ cut here ]------------ > > [14844.577021] WARNING: at lib/debugobjects.c:261 debug_print_object+0x8c/0xb0() > [14844.577023] [] debug_object_init+0x1b/0x20 > [14844.577023] Hardware name: 2356JK8 > > [14844.577026] ODEBUG: init active (active state 0) object type: hrtimer hint: watchdog_timer_fn+0x0/0x190 > [14844.577028] [] hrtimer_init+0x32/0x180 > [14844.577029] Modules linked in: > > [14844.577029] bluetooth > [14844.577031] [] watchdog_enable+0x85/0x200 > [14844.577031] cpufreq_stats > > [14844.577032] iptable_mangle > [14844.577034] [] ? get_parent_ip+0x11/0x50 > [14844.577035] nf_conntrack_ipv4 > > [14844.577036] nf_defrag_ipv4 > [14844.577037] [] smpboot_thread_fn+0x10c/0x300 > [14844.577038] xt_conntrack > > [14844.577038] nf_conntrack > [14844.577040] [] ? __smpboot_create_thread.part.2+0xc0/0xc0 > [14844.577040] dm_crypt > > [14844.577041] xfs > [14844.577043] [] kthread+0xed/0x100 > [14844.577043] arc4 > > [14844.577044] iwldvm > [14844.577045] [] ? wait_for_common+0x135/0x180 > [14844.577046] coretemp > > [14844.577047] kvm_intel > [14844.577048] [] ? kthread_create_on_node+0x160/0x160 > [14844.577049] mac80211 > > [14844.577049] kvm > [14844.577051] [] ret_from_fork+0x7c/0xb0 > [14844.577052] snd_hda_codec_hdmi > > [14844.577052] snd_hda_codec_realtek > [14844.577054] [] ? kthread_create_on_node+0x160/0x160 > [14844.577054] snd_hda_intel > [14844.577055] ---[ end trace 482f8371e46ff850 ]--- > [14844.577055] snd_hda_codec > [14844.577056] crc32c_intel > [14844.577057] iTCO_wdt > [14844.577057] iTCO_vendor_support > [14844.577058] snd_hwdep > [14844.577058] ghash_clmulni_intel > [14844.577059] snd_seq > [14844.577059] iwlwifi > [14844.577060] microcode > [14844.577060] snd_seq_device > [14844.577061] pcspkr > [14844.577062] i2c_i801 > [14844.577062] snd_pcm > [14844.577063] cfg80211 > [14844.577063] tpm_tis > [14844.577064] e1000e > [14844.577064] thinkpad_acpi > [14844.577065] snd_page_alloc > [14844.577066] lpc_ich > [14844.577066] snd_timer > [14844.577067] mfd_core > [14844.577067] snd > [14844.577068] soundcore > [14844.577068] tpm > [14844.577069] tpm_bios > [14844.577070] nfsd > [14844.577070] auth_rpcgss > [14844.577071] nfs_acl > [14844.577071] lockd > [14844.577072] sunrpc > [14844.577072] btrfs > [14844.577073] libcrc32c > [14844.577074] zlib_deflate > [14844.577074] i915 > [14844.577075] i2c_algo_bit > [14844.577075] drm_kms_helper > [14844.577076] drm > [14844.577076] i2c_core > [14844.577077] video > > [14844.577079] Pid: 27, comm: watchdog/3 Tainted: G W 3.7.0-rc8+ #4 > [14844.577079] Call Trace: > > [14844.577082] [] warn_slowpath_common+0x7f/0xc0 > > [14844.577084] [] warn_slowpath_fmt+0x46/0x50 > > [14844.577087] [] debug_print_object+0x8c/0xb0 > > [14844.577089] [] ? watchdog+0x30/0x30 > > [14844.577091] [] __debug_object_init+0x20f/0x3e0 > > [14844.577093] [] ? __schedule+0x479/0xa00 > > [14844.577095] [] debug_object_init+0x1b/0x20 > > [14844.577097] [] hrtimer_init+0x32/0x180 > > [14844.577100] [] watchdog_enable+0x85/0x200 > > [14844.577102] [] ? get_parent_ip+0x11/0x50 > > [14844.577104] [] smpboot_thread_fn+0x10c/0x300 > > [14844.577106] [] ? __smpboot_create_thread.part.2+0xc0/0xc0 > > [14844.577108] [] kthread+0xed/0x100 > > [14844.577110] [] ? wait_for_common+0x4a/0x180 > > [14844.577112] [] ? kthread_create_on_node+0x160/0x160 > > [14844.577114] [] ret_from_fork+0x7c/0xb0 > > [14844.577115] [] ? kthread_create_on_node+0x160/0x160 > [14844.577116] ---[ end trace 482f8371e46ff851 ]--- > [14844.599738] snd > [14844.599856] soundcore tpm tpm_bios nfsd auth_rpcgss nfs_acl lockd sunrpc btrfs libcrc32c zlib_deflate i915 i2c_algo_bit drm_kms_helper drm i2c_core video > [14844.600705] Pid: 15, comm: watchdog/1 Tainted: G W 3.7.0-rc8+ #4 > [14844.601082] Call Trace: > [14844.601224] [] warn_slowpath_common+0x7f/0xc0 > [14844.601555] [] warn_slowpath_fmt+0x46/0x50 > [14844.601879] [] debug_print_object+0x8c/0xb0 > [14844.602208] [] ? watchdog+0x30/0x30 > [14844.602501] [] __debug_object_init+0x20f/0x3e0 > [14844.602843] [] ? __schedule+0x479/0xa00 > [14844.603147] [] debug_object_init+0x1b/0x20 > [14844.603463] [] hrtimer_init+0x32/0x180 > [14844.603761] [] watchdog_enable+0x85/0x200 > [14844.604077] [] ? get_parent_ip+0x11/0x50 > [14844.604388] [] smpboot_thread_fn+0x10c/0x300 > [14844.604717] [] ? __smpboot_create_thread.part.2+0xc0/0xc0 > [14844.605104] [] kthread+0xed/0x100 > [14844.605381] [] ? wait_for_common+0x4a/0x180 > [14844.605704] [] ? kthread_create_on_node+0x160/0x160 > [14844.606070] [] ret_from_fork+0x7c/0xb0 > [14844.606367] [] ? kthread_create_on_node+0x160/0x160 > [14844.606728] ---[ end trace 482f8371e46ff852 ]--- >