From mboxrd@z Thu Jan 1 00:00:00 1970 Return-Path: Received: (majordomo@vger.kernel.org) by vger.kernel.org via listexpand id S932534Ab3B1Se2 (ORCPT ); Thu, 28 Feb 2013 13:34:28 -0500 Received: from na01-by1-obe.ptr.o365filtering.com ([64.4.22.90]:1207 "EHLO na01-by1-obe.outbound.o365filtering.com" rhost-flags-OK-OK-OK-OK) by vger.kernel.org with ESMTP id S1752805Ab3B1SeZ convert rfc822-to-8bit (ORCPT ); Thu, 28 Feb 2013 13:34:25 -0500 From: Haiyang Zhang To: Richard GENOUD , KY Srinivasan CC: "devel@linuxdriverproject.org" , "netdev@vger.kernel.org" , "linux-kernel@vger.kernel.org" Subject: RE: hv_netvsc: WARNING in softirq.c Thread-Topic: hv_netvsc: WARNING in softirq.c Thread-Index: AQHOFY6mlTKiRrtVMEyJsd7vlhJcdZiPmH8Q Date: Thu, 28 Feb 2013 18:33:55 +0000 Message-ID: <78fd1c1df13b449887de6e0b3505a988@DFM-DB3MBX15-06.exchange.corp.microsoft.com> References: <20130228083437.GA28143@lnx-rg> In-Reply-To: <20130228083437.GA28143@lnx-rg> Accept-Language: en-US Content-Language: en-US X-MS-Has-Attach: X-MS-TNEF-Correlator: x-originating-ip: [157.54.51.13] Content-Type: text/plain; charset="us-ascii" Content-Transfer-Encoding: 8BIT MIME-Version: 1.0 X-Forefront-Antispam-Report: CIP:131.107.1.17;CTRY:US;IPV:NLI;EFV:NLI;SFV:NSPM;SFS:(164054002)(377454001)(51704002)(13464002)(189002)(199002)(46406002)(876001)(56816002)(65816001)(77982001)(74662001)(80022001)(59766001)(23726001)(50466001)(49866001)(4396001)(44976002)(46102001)(47776003)(20776003)(76482001)(63696002)(31966008)(56776001)(47446002)(1511001)(5343655001)(66066001)(74502001)(54356001)(47976001)(16406001)(53806001)(47736001)(51856001)(54316002)(33646001)(50986001)(79102001)(24736002);DIR:OUT;SFP:;SCL:1;SRVR:CH1SR01MB611;H:hybrid.exchange.microsoft.com;RD:mail1.exchange.microsoft.com;MX:1;A:1;LANG:en; X-Forefront-PRVS: 0771670921 X-OriginatorOrg: DuplicateDomain-7923a859-03c9-4312-a77c-440aa45aaf52.microsoft.com Sender: linux-kernel-owner@vger.kernel.org List-ID: X-Mailing-List: linux-kernel@vger.kernel.org > -----Original Message----- > From: Richard GENOUD [mailto:richard.genoud@gmail.com] > Sent: Thursday, February 28, 2013 3:35 AM > To: KY Srinivasan > Cc: Haiyang Zhang; devel@linuxdriverproject.org; netdev@vger.kernel.org; > linux-kernel@vger.kernel.org > Subject: hv_netvsc: WARNING in softirq.c > > Hi, > > Here is the kernel trace I got this morning (kern.log): > Feb 27 22:32:59 devlabo kernel: [10688.187062] hv_vmbus: child device > vmbus_0_8 unregistered > Feb 27 22:34:37 devlabo kernel: [10688.187196] ------------[ cut here ]----------- > - > Feb 27 22:34:37 devlabo kernel: [10688.187203] WARNING: at /build/buildd- > linux_3.2.35-2-amd64-v9djlH/linux-3.2.35/kernel/softirq.c:159 > _local_bh_enable_ip.isra.11+0x3d/0x88() > Feb 27 22:34:37 devlabo kernel: [10688.187206] Hardware name: Virtual > Machine > Feb 27 22:34:37 devlabo kernel: [10688.187208] Modules linked in: > des_generic ecb md4 hmac nls_utf8 cifs nfsd nfs nfs_acl auth_rpcgss fscache > lockd sunrpc loop snd_pcm snd_page_alloc snd_timer snd joydev processor > hid_hyperv crc32c_intel hid thermal_sys i2c_piix4 evdev button soundcore > hv_utils i2c_core psmouse serio_raw pcspkr ext4 crc16 jbd2 mbcache > sd_mod crc_t10dif hv_netvsc hv_storvsc sg sr_mod cdrom ata_generic > floppy hv_vmbus ata_piix libata scsi_mod [last unloaded: scsi_wait_scan] > Feb 27 22:34:37 devlabo kernel: [10688.187244] Pid: 0, comm: swapper/0 Not > tainted 3.2.0-4-amd64 #1 Debian 3.2.35-2 > Feb 27 22:34:37 devlabo kernel: [10688.187246] Call Trace: > Feb 27 22:34:37 devlabo kernel: [10688.187248] [] ? > warn_slowpath_common+0x78/0x8c > Feb 27 22:34:37 devlabo kernel: [10688.187257] [] ? > _local_bh_enable_ip.isra.11+0x3d/0x88 > Feb 27 22:34:37 devlabo kernel: [10688.187262] [] ? > rndis_filter_receive+0x236/0x259 [hv_netvsc] > Feb 27 22:34:37 devlabo kernel: [10688.187267] [] ? > netvsc_channel_cb+0x37a/0x449 [hv_netvsc] > Feb 27 22:34:37 devlabo kernel: [10688.187273] [] ? > vmbus_on_event+0x91/0xdd [hv_vmbus] > Feb 27 22:34:37 devlabo kernel: [10688.187277] [] ? > add_interrupt_randomness+0x38/0x155 > Feb 27 22:34:37 devlabo kernel: [10688.187283] [] ? > tasklet_action+0x73/0xc2 > Feb 27 22:34:37 devlabo kernel: [10688.187287] [] ? > __do_softirq+0xb9/0x177 > Feb 27 22:34:37 devlabo kernel: [10688.187292] [] ? > call_softirq+0x1c/0x30 > Feb 27 22:34:37 devlabo kernel: [10688.187297] [] ? > do_softirq+0x3c/0x7b > Feb 27 22:34:37 devlabo kernel: [10688.187300] [] ? > irq_exit+0x3c/0x9a > Feb 27 22:34:37 devlabo kernel: [10688.187303] [] ? > do_IRQ+0x82/0x98 > Feb 27 22:34:37 devlabo kernel: [10688.187307] [] ? > common_interrupt+0x6e/0x6e > Feb 27 22:34:37 devlabo kernel: [10688.187309] [] ? > timekeeping_get_ns+0xd/0x2a > Feb 27 22:34:37 devlabo kernel: [10688.187317] [] ? > arch_local_irq_enable+0x4/0x8 > Feb 27 22:34:37 devlabo kernel: [10688.187321] [] ? > cpu_idle+0xe8/0xf2 > Feb 27 22:34:37 devlabo kernel: [10688.187324] [] ? > start_kernel+0x3b3/0x3be > Feb 27 22:34:37 devlabo kernel: [10688.187328] [] ? > early_idt_handlers+0x140/0x140 > Feb 27 22:34:37 devlabo kernel: [10688.187331] [] ? > x86_64_start_kernel+0x104/0x111 > Feb 27 22:34:37 devlabo kernel: [10688.187333] ---[ end trace > 39158641c6e4b495 ]--- > > and there was a lot of them : > Feb 26 22:35:14 devlabo kernel: [37398.788119] ------------[ cut here ]----------- > - > Feb 26 22:35:14 devlabo kernel: [37398.788129] WARNING: at /build/buildd- > linux_3.2.35-2-amd64-v9djlH/linux-3.2.35/kernel/softirq.c:159 > _local_bh_enable_ip.isra.11+0x3d/0x88() > Feb 26 22:35:14 devlabo kernel: [37398.788132] Hardware name: Virtual > Machine > Feb 26 22:35:14 devlabo kernel: [37398.788133] Modules linked in: nfsd nfs > nfs_acl auth_rpcgss lockd sunrpc des_generic ecb md4 hmac nls_utf8 cifs > fscache loop snd_pcm snd_page_alloc snd_timer joydev crc32c_intel > i2c_piix4 snd processor hid_hyperv hid hv_utils soundcore button > thermal_sys pcspkr i2c_core psmouse evdev serio_raw ext4 crc16 jbd2 > mbcache sd_mod crc_t10dif hv_netvsc hv_storvsc sg sr_mod cdrom > ata_generic ata_piix libata scsi_mod floppy hv_vmbus [last unloaded: > scsi_wait_scan] > Feb 26 22:35:14 devlabo kernel: [37398.788169] Pid: 0, comm: swapper/0 Not > tainted 3.2.0-4-amd64 #1 Debian 3.2.35-2 > Feb 26 22:35:14 devlabo kernel: [37398.788171] Call Trace: > Feb 26 22:35:14 devlabo kernel: [37398.788172] [] ? > warn_slowpath_common+0x78/0x8c > Feb 26 22:35:14 devlabo kernel: [37398.788181] [] ? > _local_bh_enable_ip.isra.11+0x3d/0x88 > Feb 26 22:35:14 devlabo kernel: [37398.788186] [] ? > rndis_filter_receive+0x236/0x259 [hv_netvsc] > Feb 26 22:35:14 devlabo kernel: [37398.788190] [] ? > netvsc_channel_cb+0x37a/0x449 [hv_netvsc] > Feb 26 22:35:14 devlabo kernel: [37398.788196] [] ? > vmbus_on_event+0x91/0xdd [hv_vmbus] > Feb 26 22:35:14 devlabo kernel: [37398.788200] [] ? > tasklet_action+0x73/0xc2 > Feb 26 22:35:14 devlabo kernel: [37398.788203] [] ? > __do_softirq+0xb9/0x177 > Feb 26 22:35:14 devlabo kernel: [37398.788207] [] ? > run_posix_cpu_timers+0x23/0x346 > Feb 26 22:35:14 devlabo kernel: [37398.788211] [] ? > call_softirq+0x1c/0x30 > Feb 26 22:35:14 devlabo kernel: [37398.788216] [] ? > do_softirq+0x3c/0x7b > Feb 26 22:35:14 devlabo kernel: [37398.788218] [] ? > irq_exit+0x3c/0x9a > Feb 26 22:35:14 devlabo kernel: [37398.788222] [] ? > smp_apic_timer_interrupt+0x74/0x82 > Feb 26 22:35:14 devlabo kernel: [37398.788225] [] ? > apic_timer_interrupt+0x6e/0x80 > Feb 26 22:35:14 devlabo kernel: [37398.788227] [] ? > native_sched_clock+0x27/0x2f > Feb 26 22:35:14 devlabo kernel: [37398.788233] [] ? > native_safe_halt+0x2/0x3 > Feb 26 22:35:14 devlabo kernel: [37398.788236] [] ? > default_idle+0x47/0x7f > Feb 26 22:35:14 devlabo kernel: [37398.788238] [] ? > cpu_idle+0xaf/0xf2 > Feb 26 22:35:14 devlabo kernel: [37398.788241] [] ? > start_kernel+0x3b3/0x3be > Feb 26 22:35:14 devlabo kernel: [37398.788244] [] ? > early_idt_handlers+0x140/0x140 > Feb 26 22:35:14 devlabo kernel: [37398.788247] [] ? > x86_64_start_kernel+0x104/0x111 > Feb 26 22:35:14 devlabo kernel: [37398.788249] ---[ end trace > 8f3991272dc0c5cc ]--- > Feb 26 22:35:14 devlabo kernel: [37398.789256] hv_vmbus: child device > vmbus_0_8 unregistered > > Feb 3 22:31:55 devlabo kernel: [37819.617243] ------------[ cut here ]----------- > - > Feb 3 22:31:55 devlabo kernel: [37819.617253] WARNING: at /build/buildd- > linux_3.2.35-2-amd64-v9djlH/linux-3.2.35/kernel/softirq.c:159 > _local_bh_enable_ip.isra.11+0x3d/0x88() > Feb 3 22:31:55 devlabo kernel: [37819.617257] Hardware name: Virtual > Machine > Feb 3 22:31:55 devlabo kernel: [37819.617259] Modules linked in: nfsd nfs > nfs_acl auth_rpcgss lockd sunrpc des_generic ecb md4 hmac nls_utf8 cifs > fscache loop joydev snd_pcm hid_hyperv hid snd_page_alloc snd_timer snd > hv_utils i2c_piix4 i2c_core soundcore processor psmouse crc32c_intel > thermal_sys button pcspkr evdev serio_raw ext4 crc16 jbd2 mbcache > sd_mod crc_t10dif hv_netvsc hv_storvsc sg sr_mod cdrom ata_generic > hv_vmbus ata_piix floppy libata scsi_mod [last unloaded: scsi_wait_scan] > Feb 3 22:31:55 devlabo kernel: [37819.617308] Pid: 0, comm: swapper/0 Not > tainted 3.2.0-4-amd64 #1 Debian 3.2.35-2 > Feb 3 22:31:55 devlabo kernel: [37819.617311] Call Trace: > Feb 3 22:31:55 devlabo kernel: [37819.617313] [] ? > warn_slowpath_common+0x78/0x8c > Feb 3 22:31:55 devlabo kernel: [37819.617324] [] ? > _local_bh_enable_ip.isra.11+0x3d/0x88 > Feb 3 22:31:55 devlabo kernel: [37819.617331] [] ? > rndis_filter_receive+0x236/0x259 [hv_netvsc] > Feb 3 22:31:55 devlabo kernel: [37819.617339] [] ? > netvsc_channel_cb+0x37a/0x449 [hv_netvsc] > Feb 3 22:31:55 devlabo kernel: [37819.617347] [] ? > vmbus_on_event+0x91/0xdd [hv_vmbus] > Feb 3 22:31:55 devlabo kernel: [37819.617353] [] ? > tasklet_action+0x73/0xc2 > Feb 3 22:31:55 devlabo kernel: [37819.617357] [] ? > __do_softirq+0xb9/0x177 > Feb 3 22:31:55 devlabo kernel: [37819.617362] [] ? > run_posix_cpu_timers+0x23/0x346 > Feb 3 22:31:55 devlabo kernel: [37819.617366] [] ? > raise_softirq_irqoff+0x6/0x25 > Feb 3 22:31:55 devlabo kernel: [37819.617372] [] ? > call_softirq+0x1c/0x30 > Feb 3 22:31:55 devlabo kernel: [37819.617378] [] ? > do_softirq+0x3c/0x7b > Feb 3 22:31:55 devlabo kernel: [37819.617382] [] ? > irq_exit+0x3c/0x9a > Feb 3 22:31:55 devlabo kernel: [37819.617387] [] ? > smp_apic_timer_interrupt+0x74/0x82 > Feb 3 22:31:55 devlabo kernel: [37819.617391] [] ? > apic_timer_interrupt+0x6e/0x80 > Feb 3 22:31:55 devlabo kernel: [37819.617394] [] ? > native_sched_clock+0x27/0x2f > Feb 3 22:31:55 devlabo kernel: [37819.617402] [] ? > native_safe_halt+0x2/0x3 > Feb 3 22:31:55 devlabo kernel: [37819.617407] [] ? > default_idle+0x47/0x7f > Feb 3 22:31:55 devlabo kernel: [37819.617411] [] ? > cpu_idle+0xaf/0xf2 > Feb 3 22:31:55 devlabo kernel: [37819.617415] [] ? > start_kernel+0x3b3/0x3be > Feb 3 22:31:55 devlabo kernel: [37819.617420] [] ? > early_idt_handlers+0x140/0x140 > Feb 3 22:31:55 devlabo kernel: [37819.617424] [] ? > x86_64_start_kernel+0x104/0x111 > Feb 3 22:31:55 devlabo kernel: [37819.617427] ---[ end trace > a20acc0adc92e993 ]--- > Feb 3 22:31:55 devlabo kernel: [37819.618127] hv_vmbus: child device > vmbus_0_8 unregistered > > It does not happen every day, but quite often : 4 times in February > I'll ask my sysadm if there's something special at 22h30 in the host, > because it's always happening around this time. > > Machine is debian wheezy (7) under windows server 2008 R2 We will look into this. And further info around the time will also be helpful. Thanks, - Haiyang