Return-Path: Received: (majordomo@vger.kernel.org) by vger.kernel.org via listexpand id S1751985Ab0GUMyn (ORCPT ); Wed, 21 Jul 2010 08:54:43 -0400 Received: from lennier.cc.vt.edu ([198.82.162.213]:32892 "EHLO lennier.cc.vt.edu" rhost-flags-OK-OK-OK-OK) by vger.kernel.org with ESMTP id S1751068Ab0GUMyk (ORCPT ); Wed, 21 Jul 2010 08:54:40 -0400 X-Mailer: exmh version 2.7.2 01/07/2005 with nmh-1.2 To: Linus Torvalds , Arjan van de Ven Cc: linux-kernel@vger.kernel.org Subject: kernel/panic.c warn_slowpath_common printk timestamp weirdness From: Valdis.Kletnieks@vt.edu Mime-Version: 1.0 Content-Type: multipart/signed; boundary="==_Exmh_1279716868_4552P"; micalg=pgp-sha1; protocol="application/pgp-signature" Content-Transfer-Encoding: 7bit Date: Wed, 21 Jul 2010 08:54:28 -0400 Message-ID: <62021.1279716868@localhost> X-Mirapoint-Received-SPF: 128.173.34.98 localhost Valdis.Kletnieks@vt.edu 2 pass X-Mirapoint-IP-Reputation: reputation=neutral-1, source=Fixed, refid=n/a, actions=MAILHURDLE SPF TAG X-Junkmail-Status: score=10/50, host=vivi.cc.vt.edu X-Junkmail-SD-Raw: score=unknown, refid=str=0001.0A020209.4C46EE04.02F5,ss=1,fgs=0, ip=0.0.0.0, so=2009-09-22 00:05:22, dmn=2009-09-10 00:05:08, mode=single engine X-Junkmail-IWF: false Sender: linux-kernel-owner@vger.kernel.org List-ID: X-Mailing-List: linux-kernel@vger.kernel.org Content-Length: 7906 Lines: 128 --==_Exmh_1279716868_4552P Content-Type: text/plain; charset=us-ascii Seeing this on my Dell Latitude. The timestamps from the 'cut here' and WARNING lines are different even though they're issued by sequential lines in panic.c - but then the printk timestamps remain identical even through an *entire second* WARN call. Is somebody blocking clock interrupts and failing to re-enable them, or is something different going on here? [42836.057704] IN=wlan0 OUT= MAC=ff:ff:ff:ff:ff:ff:94:44:52:1a:8f:57:08:00 SRC=192.168.2.1 DST=192.168.2.255 LEN=37 TOS=0x00 PREC=0x00 TTL=64 ID=0 DF PROTO=UDP SPT=32769 DPT=10111 LEN=17 [42860.244827] IN=wlan0 OUT= MAC=ff:ff:ff:ff:ff:ff:94:44:52:1a:8f:57:08:00 SRC=192.168.2.1 DST=192.168.2.255 LEN=37 TOS=0x00 PREC=0x00 TTL=64 ID=0 DF PROTO=UDP SPT=32769 DPT=10111 LEN=17 [42875.543219] ------------[ cut here ]------------ [42875.544006] WARNING: at lib/plist.c:57 plist_check_head+0x47/0x114() [42875.544006] Hardware name: Latitude E6500 [42875.544006] Modules linked in: ppp_async sunrpc microcode usb_storage [last unloaded: scsi_wait_scan] [42875.544006] Pid: 58070, comm: pulseaudio Tainted: G W 2.6.35-rc5-mmotm0719 #2 [42875.544006] Call Trace: [42875.544006] [] warn_slowpath_common+0x80/0x98 [42875.544006] [] warn_slowpath_null+0x15/0x17 [42875.544006] [] plist_check_head+0x47/0x114 [42875.544006] [] plist_add+0x1b/0xb1 [42875.544006] [] update_target+0x94/0xd0 [42875.544006] [] pm_qos_add_request+0x79/0x7b [42875.544006] [] snd_pcm_hw_params+0x25a/0x28a [42875.544006] [] snd_pcm_common_ioctl1+0x23b/0x980 [42875.544006] [] ? inode_has_perm.clone.18+0x92/0xa2 [42875.544006] [] snd_pcm_playback_ioctl1+0x231/0x246 [42875.544006] [] ? fd_install+0x36/0xd5 [42875.544006] [] snd_pcm_playback_ioctl+0x2a/0x2e [42875.544006] [] vfs_ioctl+0x31/0xa2 [42875.544006] [] do_vfs_ioctl+0x496/0x4c9 [42875.544006] [] sys_ioctl+0x57/0x96 [42875.544006] [] system_call_fastpath+0x16/0x1b [42875.544006] ---[ end trace 23d666d936caf587 ]--- [42875.544006] ------------[ cut here ]------------ [42875.544006] WARNING: at lib/plist.c:57 plist_check_head+0x47/0x114() [42875.544006] Hardware name: Latitude E6500 [42875.544006] Modules linked in: ppp_async sunrpc microcode usb_storage [last unloaded: scsi_wait_scan] [42875.544006] Pid: 58070, comm: pulseaudio Tainted: G W 2.6.35-rc5-mmotm0719 #2 [42875.544006] Call Trace: [42875.544006] [] warn_slowpath_common+0x80/0x98 [42875.544006] [] warn_slowpath_null+0x15/0x17 [42875.544006] [] plist_check_head+0x47/0x114 [42875.544006] [] plist_add+0xa8/0xb1 [42875.544006] [] update_target+0x94/0xd0 [42875.544006] [] pm_qos_add_request+0x79/0x7b [42875.544006] [] snd_pcm_hw_params+0x25a/0x28a [42875.544006] [] snd_pcm_common_ioctl1+0x23b/0x980 [42875.544006] [] ? inode_has_perm.clone.18+0x92/0xa2 [42875.544006] [] snd_pcm_playback_ioctl1+0x231/0x246 [42875.544006] [] ? fd_install+0x36/0xd5 [42875.544006] [] snd_pcm_playback_ioctl+0x2a/0x2e [42875.544006] [] vfs_ioctl+0x31/0xa2 [42875.544006] [] do_vfs_ioctl+0x496/0x4c9 [42875.544006] [] sys_ioctl+0x57/0x96 [42875.544006] [] system_call_fastpath+0x16/0x1b [42875.544006] ---[ end trace 23d666d936caf588 ]--- [42882.427310] ------------[ cut here ]------------ [42882.428016] WARNING: at lib/plist.c:57 plist_check_head+0x47/0x114() [42882.428016] Hardware name: Latitude E6500 [42882.428016] Modules linked in: ppp_async sunrpc microcode usb_storage [last unloaded: scsi_wait_scan] [42882.428016] Pid: 58070, comm: pulseaudio Tainted: G W 2.6.35-rc5-mmotm0719 #2 [42882.428016] Call Trace: [42882.428016] [] warn_slowpath_common+0x80/0x98 [42882.428016] [] warn_slowpath_null+0x15/0x17 [42882.428016] [] plist_check_head+0x47/0x114 [42882.428016] [] plist_del+0x1f/0x8b [42882.428016] [] update_target+0x87/0xd0 [42882.428016] [] pm_qos_remove_request+0x4c/0x5c [42882.428016] [] snd_pcm_common_ioctl1+0x2eb/0x980 [42882.428016] [] ? inode_has_perm.clone.18+0x92/0xa2 [42882.428016] [] snd_pcm_playback_ioctl1+0x231/0x246 [42882.428016] [] ? trace_preempt_on+0x15/0x28 [42882.428016] [] ? unmap_region+0xbd/0xcc [42882.428016] [] snd_pcm_playback_ioctl+0x2a/0x2e [42882.428016] [] vfs_ioctl+0x31/0xa2 [42882.428016] [] do_vfs_ioctl+0x496/0x4c9 [42882.428016] [] sys_ioctl+0x57/0x96 [42882.428016] [] ? unlink_file_vma+0x2d/0x4d [42882.428016] [] system_call_fastpath+0x16/0x1b [42882.428016] ---[ end trace 23d666d936caf589 ]--- [42882.428016] ------------[ cut here ]------------ [42882.428016] WARNING: at lib/plist.c:57 plist_check_head+0x47/0x114() [42882.428016] Hardware name: Latitude E6500 [42882.428016] Modules linked in: ppp_async sunrpc microcode usb_storage [last unloaded: scsi_wait_scan] [42882.428016] Pid: 58070, comm: pulseaudio Tainted: G W 2.6.35-rc5-mmotm0719 #2 [42882.428016] Call Trace: [42882.428016] [] warn_slowpath_common+0x80/0x98 [42882.428016] [] warn_slowpath_null+0x15/0x17 [42882.428016] [] plist_check_head+0x47/0x114 [42882.428016] [] plist_del+0x82/0x8b [42882.428016] [] update_target+0x87/0xd0 [42882.428016] [] pm_qos_remove_request+0x4c/0x5c [42882.428016] [] snd_pcm_common_ioctl1+0x2eb/0x980 [42882.428016] [] ? inode_has_perm.clone.18+0x92/0xa2 [42882.428016] [] snd_pcm_playback_ioctl1+0x231/0x246 [42882.428016] [] ? trace_preempt_on+0x15/0x28 [42882.428016] [] ? unmap_region+0xbd/0xcc [42882.428016] [] snd_pcm_playback_ioctl+0x2a/0x2e [42882.428016] [] vfs_ioctl+0x31/0xa2 [42882.428016] [] do_vfs_ioctl+0x496/0x4c9 [42882.428016] [] sys_ioctl+0x57/0x96 [42882.428016] [] ? unlink_file_vma+0x2d/0x4d [42882.428016] [] system_call_fastpath+0x16/0x1b [42882.428016] ---[ end trace 23d666d936caf58a ]--- [42884.623327] IN=wlan0 OUT= MAC=ff:ff:ff:ff:ff:ff:94:44:52:1a:8f:57:08:00 SRC=192.168.2.1 DST=192.168.2.255 LEN=37 TOS=0x00 PREC=0x00 TTL=64 ID=0 DF PROTO=UDP SPT=32769 DPT=10111 LEN=17 [42914.070946] IN=wlan0 OUT= MAC=ff:ff:ff:ff:ff:ff:94:44:52:1a:8f:57:08:00 SRC=192.168.2.1 DST=192.168.2.255 LEN=37 TOS=0x00 PREC=0x00 TTL=64 ID=0 DF PROTO=UDP SPT=32769 DPT=10111 LEN=17 --==_Exmh_1279716868_4552P Content-Type: application/pgp-signature -----BEGIN PGP SIGNATURE----- Version: GnuPG v1.4.10 (GNU/Linux) Comment: Exmh version 2.5 07/13/2001 iD8DBQFMRu4DcC3lWbTT17ARAg0lAJ9t912xy1VToZ5ByjMEmsU8WZLWQACg4Cqt olfpaBJswPkxwwEGqh6ynfg= =dY/v -----END PGP SIGNATURE----- --==_Exmh_1279716868_4552P-- -- To unsubscribe from this list: send the line "unsubscribe linux-kernel" in the body of a message to majordomo@vger.kernel.org More majordomo info at http://vger.kernel.org/majordomo-info.html Please read the FAQ at http://www.tux.org/lkml/