From mboxrd@z Thu Jan 1 00:00:00 1970 From: Ritu kaur Subject: Re: domU guest for xcp 0.1.1 Date: Thu, 18 Mar 2010 06:43:49 -0700 Message-ID: <29b32d341003180643o326f7f43h97c25bd104f3b658@mail.gmail.com> References: <29b32d341003141329v3c6a73c0y8030cf3c6736634c@mail.gmail.com> <29b32d341003150642o4e2620edsf154b19d78aa7f42@mail.gmail.com> <1268660645.10129.25070.camel@zakaz.uk.xensource.com> <29b32d341003150646o4d215dfel1c2a2bc6d287edc@mail.gmail.com> <29b32d341003151904m2a992be5s74697d6047b864c6@mail.gmail.com> <1268725069.8652.4179.camel@localhost.localdomain> <20100316152259.GO1878@reaktio.net> <29b32d341003161625w2969f2daib3408561920793d3@mail.gmail.com> <29b32d341003171144k628a7741x17b6658731f96e4b@mail.gmail.com> <1268903824.10129.38718.camel@zakaz.uk.xensource.com> Mime-Version: 1.0 Content-Type: multipart/mixed; boundary="===============0911257449==" Return-path: In-Reply-To: <1268903824.10129.38718.camel@zakaz.uk.xensource.com> List-Unsubscribe: , List-Post: List-Help: List-Subscribe: , Sender: xen-devel-bounces@lists.xensource.com Errors-To: xen-devel-bounces@lists.xensource.com To: Ian Campbell Cc: "xen-devel@lists.xensource.com" List-Id: xen-devel@lists.xenproject.org --===============0911257449== Content-Type: multipart/alternative; boundary=000e0cd11096b9bf980482136b9b --000e0cd11096b9bf980482136b9b Content-Type: text/plain; charset=ISO-8859-1 Hi Ian. pcifront_handler_aer is the callback function. ... err = bind_evtchn_to_irqhandler(pdev->evtchn, pcifront_handler_aer, 0, "pcifront", pdev); if (err < 0) { xenbus_free_evtchn(pdev->xdev, pdev->evtchn); xenbus_dev_fatal(pdev->xdev, err, "Failed to bind evtchn to " "irqhandler.\n"); return err; } ... In pcifront_handler_aer, schedule_pcifront_aer_op is called. irqreturn_t pcifront_handler_aer(int irq, void *dev) { struct pcifront_device *pdev = dev; schedule_pcifront_aer_op(pdev); return IRQ_HANDLED; } So I am assuming it is called during normal path as well. Yes my nic device is sharing interrupts(IRQ17) with usb and ide devices in dom0. cat /proc/interrupts in domU shows interrupts are never received by the interface(probably confirmed that pcifront itself doesn't receive interrupts). I am only passing 0000:08:01.0 nic device to a domU. It shares IRQ 17 with usb/ide devices in dom0. Thanks On Thu, Mar 18, 2010 at 2:17 AM, Ian Campbell wrote: > I thought AER stuff was only called on error conditions and isn't in the > normal pci passthrough paths so I don't think you would expect to see > any messages from schedule_pcifront_aer_op in normal operation. > > I'm not sure about your actual problem (we're pushing the boundaries of > my immediate knowledge of pcifront/back here), it looks as if it might > relate to the interrupt being shared with other devices in domain 0? > What does /proc/interrupts say on both ends? Which devices are you > trying to passthrough, only 0000:08:01.0? Does 0000:08:01.0 share an > interrupt with your USB controller and/or ATA controller in domain 0? > > Ian. > > On Wed, 2010-03-17 at 18:44 +0000, Ritu kaur wrote: > > Pasi, Ian > > > > I debugged this further with the assumption that IRQ follows the path > > IDT->Hypervisor->pciback->pcifront->actual_device. I added printk > > message while binding to a event-chnl and event-chnl callback > > function in pcifront. I do see my printk message(while binding to > > event-chnl in domU) so I know kernel has correct module. After nic > > device is enabled via ifconfig in domU, I do not see messages (added > > in event-chnl callback function) from pcifront so I believe interrupt > > is not delivered to pcifront itself. > > > > static inline void schedule_pcifront_aer_op(struct pcifront_device > > *pdev) > > { > > if (test_bit(_XEN_PCIB_active, (unsigned long > > *)&pdev->sh_info->flags) > > && !test_and_set_bit(_PDEVB_op_active, &pdev->flags)) > > { > > dev_dbg(&pdev->xdev->dev, "schedule aer frontend job > > \n"); > > printk(KERN_DEBUG "schedule aer frontend job %d\n", > > pdev->irq); <<<<<<< never seen in dmesg in domU > > schedule_work(&pdev->op_work); > > } > > } > > > > dmesg on dom0 says "nobody cared...", forum has some old discussions > > around 2006 and hence didn't look into it in detail. > > > > Inputs will be very much appreciated. > > > > dmesg in dom0 and domU follows. > > > > Thanks > > /**********************dmesg on > > dom0***************************************/ > > pciback 0000:08:01.0: PCI INT A -> GSI 17 (level, low) -> IRQ 17 > > irq 17: nobody cared (try booting with the "irqpoll" option) > > Pid: 0, comm: swapper Tainted: G > > 2.6.27.42-0.1.1.xs0.1.1.737.1065xen #1 > > [] __report_bad_irq+0x27/0x90 > > [] note_interrupt+0x2fc/0x330 > > [] ? usb_hcd_irq+0x4d/0xe0 [usbcore] > > [] ? handle_IRQ_event+0x31/0x90 > > [] handle_level_irq+0xe4/0x110 > > [] do_IRQ+0x43/0x90 > > [] ? ktime_get+0x19/0x40 > > [] evtchn_do_upcall+0xdf/0x1f0 > > [] hypervisor_callback+0x41/0x49 > > [] ? xen_safe_halt+0x8b/0xc0 > > [] xen_idle+0x1e/0x50 > > [] cpu_idle+0x58/0xa0 > > [] rest_init+0x4e/0x60 > > ======================= > > handlers: > > [] (usb_hcd_irq+0x0/0xe0 [usbcore]) > > Disabling IRQ #17 > > ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen > > ata1.00: cmd ca/00:08:31:08:14/00:00:00:00:00/e0 tag 0 dma 4096 out > > res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout) > > ata1.00: status: { DRDY } > > ata1: soft resetting link > > ata1.00: qc timeout (cmd 0x27) > > ata1.00: failed to read native max address (err_mask=0x4) > > ata1.00: revalidation failed (errno=-5) > > ata1: soft resetting link > > ata1.00: qc timeout (cmd 0x27) > > ata1.00: failed to read native max address (err_mask=0x4) > > ata1.00: revalidation failed (errno=-5) > > ata1: soft resetting link > > ata1.00: qc timeout (cmd 0x27) > > ata1.00: failed to read native max address (err_mask=0x4) > > ata1.00: revalidation failed (errno=-5) > > ata1.00: disabled > > ata1.00: device reported invalid CHS sector 0 > > ata1: soft resetting link > > ata1: EH complete > > sd 0:0:0:0: [sda] Result: hostbyte=DID_BAD_TARGET > > driverbyte=DRIVER_OK,SUGGEST_OK > > end_request: I/O error, dev sda, sector 1312817 > > Buffer I/O error on device sda1, logical block 164102 > > lost page write due to I/O error on sda1 > > > > > > /**************************dmesg on > > domU*********************************************/ > > [ 5.994657] EXT3 FS on xvda1, internal journal > > [ 8.431645] loop: module loaded > > [ 10.043554] NET: Registered protocol family 10 > > [ 10.044013] lo: Disabled Privacy Extensions > > [ 11.859410] lp: driver loaded but no devices found > > [ 11.965333] ppdev: user-space parallel port driver > > [ 20.076012] eth0: no IPv6 routers present > > [ 170.192510] ncr 0000:00:00.0: enabling device (0000 -> 0002) > > [ 170.192551] ncr 0000:00:00.0: Xen PCI enabling IRQ: 17 > > [ 170.192571] ncr: Found an ncr device (cfg revision 0)... > > [ 287.816020] ------------[ cut here ]------------ > > [ 287.816031] WARNING: at net/sched/sch_generic.c:261 dev_watchdog > > +0xf8/0x188() > > [ 287.816037] NETDEV WATCHDOG: ncr (): transmit queue 0 timed out > > [ 287.816041] Modules linked in: ncr ppdev parport_pc lp parport > > acpi_cpufreq processor cpufreq_powersave cpufreq_stats > > cpufreq_ondemand freq_table cpufreq_userspace cpufreq_conservative > > ipv6 loop evdev pcspkr xen_netfront ext3 jbd mbcache xen_blkfront > > thermal_sys > > [ 287.816113] Pid: 0, comm: swapper Not tainted 2.6.32.9 #4 > > [ 287.816118] Call Trace: > > [ 287.816127] [] ? dev_watchdog+0xf8/0x188 > > [ 287.816135] [] ? dev_watchdog+0xf8/0x188 > > [ 287.816143] [] ? warn_slowpath_common+0x5e/0x8a > > [ 287.816151] [] ? warn_slowpath_fmt+0x26/0x2a > > [ 287.816159] [] ? dev_watchdog+0xf8/0x188 > > [ 287.816168] [] ? check_events+0x8/0xc > > [ 287.816175] [] ? xen_force_evtchn_callback+0xc/0x10 > > [ 287.816183] [] ? check_events+0x8/0xc > > [ 287.816191] [] ? xen_restore_fl_direct_end+0x0/0x1 > > [ 287.816200] [] ? _spin_unlock_irqrestore+0xe/0x10 > > [ 287.816209] [] ? mod_timer+0x15f/0x168 > > [ 287.816217] [] ? dev_watchdog+0x0/0x188 > > [ 287.816224] [] ? run_timer_softirq+0x195/0x217 > > [ 287.816232] [] ? __do_softirq+0xaa/0x151 > > [ 287.816240] [] ? do_softirq+0x31/0x3c > > [ 287.816247] [] ? irq_exit+0x26/0x58 > > [ 287.816256] [] ? xen_evtchn_do_upcall+0x13f/0x151 > > [ 287.816264] [] ? xen_do_upcall+0x7/0xc > > [ 287.816272] [] ? hypercall_page+0x3a7/0x1001 > > [ 287.816280] [] ? xen_safe_halt+0xf/0x1b > > [ 287.816287] [] ? xen_idle+0x23/0x30 > > [ 287.816295] [] ? cpu_idle+0x46/0x62 > > [ 287.816303] [] ? start_kernel+0x2c7/0x2ca > > [ 287.816310] [] ? xen_start_kernel+0x5e6/0x5ee > > [ 287.816315] ---[ end trace 00c16cce2318c073 ]--- > > [ 287.816320] ncr: Transmit timeout on ncr at 4294964250, latency 583 > > [ 291.816017] ncr: Transmit timeout on ncr at 4294965250, latency > > 1000 > > ... > > > > [ 412.673801] end_request: I/O error, dev xvda, sector 7608215 > > [ 412.673826] end_request: I/O error, dev xvda, sector 7608223 > > [ 412.673837] end_request: I/O error, dev xvda, sector 7608231 > > [ 480.052035] INFO: task kjournald:565 blocked for more than 120 > > seconds. > > [ 480.052047] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" > > disables this message. > > [ 480.052057] kjournald D 121f1575 0 565 2 0x00000000 > > [ 480.052069] cf864d80 00000246 c136b7c0 121f1575 c1c25040 c13ce460 > > c13ce460 cf864f38 > > [ 480.052091] c26fb460 00000000 5737fa96 00000045 c136b7c0 121f1e2a > > c1052d6d 6c3e6a53 > > [ 480.052111] 00000000 121f1e2a 00000000 cf894690 cf864f38 cf864d80 > > c26fb894 c26fb460 > > [ 480.052131] Call Trace: > > [ 480.052143] [] ? ktime_get_ts+0xd7/0xdf > > [ 480.052154] [] ? io_schedule+0x5f/0x98 > > [ 480.052162] [] ? sync_buffer+0x30/0x33 > > [ 480.052169] [] ? __wait_on_bit+0x33/0x58 > > [ 480.052176] [] ? sync_buffer+0x0/0x33 > > [ 480.052183] [] ? out_of_line_wait_on_bit+0xb6/0xbe > > [ 480.052190] [] ? sync_buffer+0x0/0x33 > > [ 480.052198] [] ? wake_bit_function+0x0/0x3c > > [ 480.052205] [] ? __wait_on_buffer+0x16/0x18 > > [ 480.052223] [] ? journal_commit_transaction+0x85a/0xd6d > > [jbd] > > [ 480.052235] [] ? finish_task_switch+0x3d/0x9c > > [ 480.052243] [] ? check_events+0x8/0xc > > [ 480.052250] [] ? xen_restore_fl_direct_end+0x0/0x1 > > [ 480.052258] [] ? _spin_unlock_irqrestore+0xe/0x10 > > [ 480.052267] [] ? try_to_del_timer_sync+0x79/0x80 > > [ 480.052276] [] ? kjournald+0xbb/0x1e5 [jbd] > > [ 480.052283] [] ? autoremove_wake_function+0x0/0x2d > > [ 480.052292] [] ? kjournald+0x0/0x1e5 [jbd] > > [ 480.052299] [] ? kthread+0x61/0x66 > > [ 480.052305] [] ? kthread+0x0/0x66 > > [ 480.052313] [] ? kernel_thread_helper+0x7/0x10 > > [ 480.052320] INFO: task rsyslogd:1929 blocked for more than 120 > > seconds. > > [ 480.052328] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" > > disables this message. > > [ 480.052337] rsyslogd D 00001000 0 1929 1 0x00000000 > > [ 480.052346] c1c20d40 00000286 d0877650 00001000 c1c25200 c13ce460 > > c13ce460 c1c20ef8 > > [ 480.052367] c26fb460 00000000 c1cd5600 c1cf02c0 cf4693ec cf576518 > > c1005ff4 c26f0a5c > > [ 480.052387] cf99fd98 cf99fdac c100665c c26f025c c1c20ef8 c26f0a5c > > cf99fd98 cf99fdac > > [ 480.052407] Call Trace: > > [ 480.052418] [] ? __ext3_get_inode_loc+0xc7/0x275 [ext3] > > [ 480.052426] [] ? xen_force_evtchn_callback+0xc/0x10 > > [ 480.052434] [] ? check_events+0x8/0xc > > [ 480.052442] [] ? do_get_write_access+0x1f8/0x3b5 [jbd] > > [ 480.052450] [] ? wake_bit_function+0x0/0x3c > > [ 480.052459] [] ? journal_get_write_access+0x18/0x26 > > [jbd] > > [ 480.052469] [] ? __ext3_journal_get_write_access > > +0x13/0x32 [ext3] > > [ 480.052479] [] ? ext3_reserve_inode_write+0x2d/0x5d > > [ext3] > > [ 480.052489] [] ? ext3_mark_inode_dirty+0x11/0x27 [ext3] > > [ 480.052499] [] ? ext3_dirty_inode+0x50/0x63 [ext3] > > [ 480.052507] [] ? __mark_inode_dirty+0x20/0x10c > > [ 480.052515] [] ? file_update_time+0xbe/0xdf > > [ 480.052523] [] ? __generic_file_aio_write+0x2f7/0x452 > > [ 480.052531] [] ? xen_restore_fl_direct_end+0x0/0x1 > > [ 480.052539] [] ? _spin_unlock_irqrestore+0xe/0x10 > > [ 480.052546] [] ? hrtimer_try_to_cancel+0x6e/0x83 > > [ 480.052554] [] ? hrtimer_try_to_cancel+0x7c/0x83 > > [ 480.052561] [] ? generic_file_aio_write+0x51/0x93 > > [ 480.052571] [] ? do_sync_write+0xc0/0x107 > > [ 480.052578] [] ? autoremove_wake_function+0x0/0x2d > > [ 480.052586] [] ? pick_next_task_fair+0x95/0x9c > > [ 480.052593] [] ? schedule+0x5ea/0x671 > > [ 480.052601] [] ? security_file_permission+0xc/0xd > > [ 480.052609] [] ? do_sync_write+0x0/0x107 > > [ 480.052616] [] ? vfs_write+0x84/0x12f > > [ 480.052623] [] ? sys_write+0x3c/0x63 > > [ 480.052630] [] ? sysenter_do_call+0x12/0x28 > > > > > > > > > > > > > > > --000e0cd11096b9bf980482136b9b Content-Type: text/html; charset=ISO-8859-1 Content-Transfer-Encoding: quoted-printable Hi Ian.

=A0pcifront_handler_aer is the callback function.

...=
err =3D bind_evtchn_to_irqhandler(pdev->evtchn, pcifront_handler_aer= ,
=A0=A0=A0=A0=A0=A0=A0=A0=A0=A0=A0=A0=A0=A0=A0 0, "pcifront",= pdev);
=A0=A0=A0=A0=A0=A0=A0 if (err < 0) {
=A0=A0=A0=A0=A0=A0=A0=A0=A0=A0=A0=A0=A0=A0=A0 xenbus_free_evtchn(pdev->x= dev, pdev->evtchn);
=A0=A0=A0=A0=A0=A0=A0=A0=A0=A0=A0=A0=A0=A0=A0 xen= bus_dev_fatal(pdev->xdev, err, "Failed to bind evtchn to "
= =A0=A0=A0=A0=A0=A0=A0=A0=A0=A0=A0=A0=A0=A0=A0=A0=A0=A0=A0=A0=A0=A0=A0=A0=A0= =A0=A0=A0=A0=A0=A0=A0 "irqhandler.\n");
=A0=A0=A0=A0=A0=A0=A0=A0=A0=A0=A0=A0=A0=A0=A0 return err;
=A0=A0=A0=A0= =A0=A0=A0 }
...

In pcifront_handler_aer, schedule_pcifront_aer_op= is called.

irqreturn_t pcifront_handler_aer(int irq, void *dev)
= {
=A0=A0=A0=A0=A0=A0=A0 struct pcifront_device *pdev =3D dev;
=A0=A0=A0=A0=A0=A0=A0 schedule_pcifront_aer_op(pdev);
=A0=A0=A0=A0=A0=A0= =A0 return IRQ_HANDLED;
}

So I am assuming it is called during no= rmal path as well.

Yes my nic device is sharing interrupts(IRQ17) wi= th usb and ide devices in dom0.

cat /proc/interrupts in domU shows interrupts are never received by the= interface(probably confirmed that pcifront itself doesn't receive inte= rrupts). I am only passing 0000:08:01.0 nic device to a domU. It shares IRQ= 17 with usb/ide devices in dom0.

Thanks

On Thu, Mar 18, 2010 at 2:17 A= M, Ian Campbell <Ian.Campbell@citrix.com> wrote:
I thought AER stuff was only called on error conditions a= nd isn't in the
normal pci passthrough paths so I don't think you would expect to see any messages from schedule_pcifront_aer_op in normal operation.

I'm not sure about your actual problem (we're pushing the boundarie= s of
my immediate knowledge of pcifront/back here), it looks as if it might
relate to the interrupt being shared with other devices in domain 0?
What does /proc/interrupts say on both ends? Which devices are you
trying to passthrough, only 0000:08:01.0? Does 0000:08:01.0 share an
interrupt with your USB controller and/or ATA controller in domain 0?

Ian.

On Wed, 2010-03-17 at 18:44 +0000, Ritu kaur wrote:
> Pasi, Ian
>
> I debugged this further with the assumption that IRQ follows the path<= br> > IDT->Hypervisor->pciback->pcifront->actual_device. I added= printk
> message while binding to a event-chnl =A0and event-chnl callback
> function in pcifront. I do see my printk message(while binding to
> event-chnl in domU) so I know kernel has correct module. After nic
> device is enabled via ifconfig in domU, I do not see messages (added > in event-chnl callback function) from pcifront so I believe interrupt<= br> > is not delivered to pcifront itself.
>
> static inline void schedule_pcifront_aer_op(struct pcifront_device
> *pdev)
> {
> =A0 =A0 =A0 =A0 if (test_bit(_XEN_PCIB_active, (unsigned long
> *)&pdev->sh_info->flags)
> =A0 =A0 =A0 =A0 =A0 =A0 =A0 =A0 && !test_and_set_bit(_PDEVB_op= _active, &pdev->flags))
> {
> =A0 =A0 =A0 =A0 =A0 =A0 =A0 =A0 dev_dbg(&pdev->xdev->dev, &q= uot;schedule aer frontend job
> \n");
> =A0 =A0 =A0 =A0 =A0 =A0 =A0 =A0 printk(KERN_DEBUG "schedule aer f= rontend job %d\n",
> pdev->irq); <<<<<<< never seen in dmesg in dom= U
> =A0 =A0 =A0 =A0 =A0 =A0 =A0 =A0 schedule_work(&pdev->op_work);<= br> > =A0 =A0 =A0 =A0 }
> }
>
> dmesg on dom0 says "nobody cared...", forum has some old dis= cussions
> around 2006 and hence didn't look into it in detail.
>
> Inputs will be very much appreciated.
>
> dmesg in dom0 and domU follows.
>
> Thanks
> /**********************dmesg on
> dom0***************************************/
> pciback 0000:08:01.0: PCI INT A -> GSI 17 (level, low) -> IRQ 17=
> irq 17: nobody cared (try booting with the "irqpoll" option)=
> Pid: 0, comm: swapper Tainted: G
> 2.6.27.42-0.1.1.xs0.1.1.737.1065xen #1
> =A0[<c01544f7>] __report_bad_irq+0x27/0x90
> =A0[<c015485c>] note_interrupt+0x2fc/0x330
> =A0[<f01df92d>] ? usb_hcd_irq+0x4d/0xe0 [usbcore]
> =A0[<c0153931>] ? handle_IRQ_event+0x31/0x90
> =A0[<c01551e4>] handle_level_irq+0xe4/0x110
> =A0[<c0107733>] do_IRQ+0x43/0x90
> =A0[<c01413b9>] ? ktime_get+0x19/0x40
> =A0[<c026cfcf>] evtchn_do_upcall+0xdf/0x1f0
> =A0[<c0105565>] hypervisor_callback+0x41/0x49
> =A0[<c010797b>] ? xen_safe_halt+0x8b/0xc0
> =A0[<c010afde>] xen_idle+0x1e/0x50
> =A0[<c0103728>] cpu_idle+0x58/0xa0
> =A0[<c0338f4e>] rest_init+0x4e/0x60
> =A0=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D= =3D
> handlers:
> [<f01df8e0>] (usb_hcd_irq+0x0/0xe0 [usbcore])
> Disabling IRQ #17
> ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
> ata1.00: cmd ca/00:08:31:08:14/00:00:00:00:00/e0 tag 0 dma 4096 out > =A0 =A0 =A0 =A0 =A0res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (= timeout)
> ata1.00: status: { DRDY }
> ata1: soft resetting link
> ata1.00: qc timeout (cmd 0x27)
> ata1.00: failed to read native max address (err_mask=3D0x4)
> ata1.00: revalidation failed (errno=3D-5)
> ata1: soft resetting link
> ata1.00: qc timeout (cmd 0x27)
> ata1.00: failed to read native max address (err_mask=3D0x4)
> ata1.00: revalidation failed (errno=3D-5)
> ata1: soft resetting link
> ata1.00: qc timeout (cmd 0x27)
> ata1.00: failed to read native max address (err_mask=3D0x4)
> ata1.00: revalidation failed (errno=3D-5)
> ata1.00: disabled
> ata1.00: device reported invalid CHS sector 0
> ata1: soft resetting link
> ata1: EH complete
> sd 0:0:0:0: [sda] Result: hostbyte=3DDID_BAD_TARGET
> driverbyte=3DDRIVER_OK,SUGGEST_OK
> end_request: I/O error, dev sda, sector 1312817
> Buffer I/O error on device sda1, logical block 164102
> lost page write due to I/O error on sda1
>
>
> /**************************dmesg on
> domU*********************************************/
> [ =A0 =A05.994657] EXT3 FS on xvda1, internal journal
> [ =A0 =A08.431645] loop: module loaded
> [ =A0 10.043554] NET: Registered protocol family 10
> [ =A0 10.044013] lo: Disabled Privacy Extensions
> [ =A0 11.859410] lp: driver loaded but no devices found
> [ =A0 11.965333] ppdev: user-space parallel port driver
> [ =A0 20.076012] eth0: no IPv6 routers present
> [ =A0170.192510] ncr 0000:00:00.0: enabling device (0000 -> 0002) > [ =A0170.192551] ncr 0000:00:00.0: Xen PCI enabling IRQ: 17
> [ =A0170.192571] ncr: Found an ncr device (cfg revision 0)...
> [ =A0287.816020] ------------[ cut here ]------------
> [ =A0287.816031] WARNING: at net/sched/sch_generic.c:261 dev_watchdog<= br> > +0xf8/0x188()
> [ =A0287.816037] NETDEV WATCHDOG: ncr (): transmit queue 0 timed out > [ =A0287.816041] Modules linked in: ncr ppdev parport_pc lp parport > acpi_cpufreq processor cpufreq_powersave cpufreq_stats
> cpufreq_ondemand freq_table cpufreq_userspace cpufreq_conservative
> ipv6 loop evdev pcspkr xen_netfront ext3 jbd mbcache xen_blkfront
> thermal_sys
> [ =A0287.816113] Pid: 0, comm: swapper Not tainted 2.6.32.9 #4
> [ =A0287.816118] Call Trace:
> [ =A0287.816127] =A0[<c11f2db1>] ? dev_watchdog+0xf8/0x188
> [ =A0287.816135] =A0[<c11f2db1>] ? dev_watchdog+0xf8/0x188
> [ =A0287.816143] =A0[<c1037a1b>] ? warn_slowpath_common+0x5e/0x8= a
> [ =A0287.816151] =A0[<c1037a79>] ? warn_slowpath_fmt+0x26/0x2a > [ =A0287.816159] =A0[<c11f2db1>] ? dev_watchdog+0xf8/0x188
> [ =A0287.816168] =A0[<c100665c>] ? check_events+0x8/0xc
> [ =A0287.816175] =A0[<c1005ff4>] ? xen_force_evtchn_callback+0xc= /0x10
> [ =A0287.816183] =A0[<c100665c>] ? check_events+0x8/0xc
> [ =A0287.816191] =A0[<c1006653>] ? xen_restore_fl_direct_end+0x0= /0x1
> [ =A0287.816200] =A0[<c124f4ea>] ? _spin_unlock_irqrestore+0xe/0= x10
> [ =A0287.816209] =A0[<c1042a74>] ? mod_timer+0x15f/0x168
> [ =A0287.816217] =A0[<c11f2cb9>] ? dev_watchdog+0x0/0x188
> [ =A0287.816224] =A0[<c104263c>] ? run_timer_softirq+0x195/0x217=
> [ =A0287.816232] =A0[<c103cb18>] ? __do_softirq+0xaa/0x151
> [ =A0287.816240] =A0[<c103cbf0>] ? do_softirq+0x31/0x3c
> [ =A0287.816247] =A0[<c103ccc6>] ? irq_exit+0x26/0x58
> [ =A0287.816256] =A0[<c118f14b>] ? xen_evtchn_do_upcall+0x13f/0x= 151
> [ =A0287.816264] =A0[<c1009087>] ? xen_do_upcall+0x7/0xc
> [ =A0287.816272] =A0[<c10023a7>] ? hypercall_page+0x3a7/0x1001 > [ =A0287.816280] =A0[<c1006075>] ? xen_safe_halt+0xf/0x1b
> [ =A0287.816287] =A0[<c1004083>] ? xen_idle+0x23/0x30
> [ =A0287.816295] =A0[<c100773c>] ? cpu_idle+0x46/0x62
> [ =A0287.816303] =A0[<c136e7e0>] ? start_kernel+0x2c7/0x2ca
> [ =A0287.816310] =A0[<c1370d33>] ? xen_start_kernel+0x5e6/0x5ee<= br> > [ =A0287.816315] ---[ end trace 00c16cce2318c073 ]---
> [ =A0287.816320] ncr: Transmit timeout on ncr at 4294964250, latency 5= 83
> [ =A0291.816017] ncr: Transmit timeout on ncr at 4294965250, latency > 1000
> ...
>
> [ =A0412.673801] end_request: I/O error, dev xvda, sector 7608215
> [ =A0412.673826] end_request: I/O error, dev xvda, sector 7608223
> [ =A0412.673837] end_request: I/O error, dev xvda, sector 7608231
> [ =A0480.052035] INFO: task kjournald:565 blocked for more than 120 > seconds.
> [ =A0480.052047] "echo 0 > /proc/sys/kernel/hung_task_timeout_= secs"
> disables this message.
> [ =A0480.052057] kjournald =A0 =A0 D 121f1575 =A0 =A0 0 =A0 565 =A0 = =A0 =A02 0x00000000
> [ =A0480.052069] =A0cf864d80 00000246 c136b7c0 121f1575 c1c25040 c13ce= 460
> c13ce460 cf864f38
> [ =A0480.052091] =A0c26fb460 00000000 5737fa96 00000045 c136b7c0 121f1= e2a
> c1052d6d 6c3e6a53
> [ =A0480.052111] =A000000000 121f1e2a 00000000 cf894690 cf864f38 cf864= d80
> c26fb894 c26fb460
> [ =A0480.052131] Call Trace:
> [ =A0480.052143] =A0[<c1052d6d>] ? ktime_get_ts+0xd7/0xdf
> [ =A0480.052154] =A0[<c124e1eb>] ? io_schedule+0x5f/0x98
> [ =A0480.052162] =A0[<c10d49a2>] ? sync_buffer+0x30/0x33
> [ =A0480.052169] =A0[<c124e645>] ? __wait_on_bit+0x33/0x58
> [ =A0480.052176] =A0[<c10d4972>] ? sync_buffer+0x0/0x33
> [ =A0480.052183] =A0[<c124e720>] ? out_of_line_wait_on_bit+0xb6/= 0xbe
> [ =A0480.052190] =A0[<c10d4972>] ? sync_buffer+0x0/0x33
> [ =A0480.052198] =A0[<c104b97f>] ? wake_bit_function+0x0/0x3c > [ =A0480.052205] =A0[<c10d493f>] ? __wait_on_buffer+0x16/0x18 > [ =A0480.052223] =A0[<d084622d>] ? journal_commit_transaction+0x= 85a/0xd6d
> [jbd]
> [ =A0480.052235] =A0[<c10323bf>] ? finish_task_switch+0x3d/0x9c<= br> > [ =A0480.052243] =A0[<c100665c>] ? check_events+0x8/0xc
> [ =A0480.052250] =A0[<c1006653>] ? xen_restore_fl_direct_end+0x0= /0x1
> [ =A0480.052258] =A0[<c124f4ea>] ? _spin_unlock_irqrestore+0xe/0= x10
> [ =A0480.052267] =A0[<c1042c5a>] ? try_to_del_timer_sync+0x79/0x= 80
> [ =A0480.052276] =A0[<d0848b6f>] ? kjournald+0xbb/0x1e5 [jbd] > [ =A0480.052283] =A0[<c104b952>] ? autoremove_wake_function+0x0/= 0x2d
> [ =A0480.052292] =A0[<d0848ab4>] ? kjournald+0x0/0x1e5 [jbd]
> [ =A0480.052299] =A0[<c104b71e>] ? kthread+0x61/0x66
> [ =A0480.052305] =A0[<c104b6bd>] ? kthread+0x0/0x66
> [ =A0480.052313] =A0[<c1009037>] ? kernel_thread_helper+0x7/0x10=
> [ =A0480.052320] INFO: task rsyslogd:1929 blocked for more than 120 > seconds.
> [ =A0480.052328] "echo 0 > /proc/sys/kernel/hung_task_timeout_= secs"
> disables this message.
> [ =A0480.052337] rsyslogd =A0 =A0 =A0D 00001000 =A0 =A0 0 =A01929 =A0 = =A0 =A01 0x00000000
> [ =A0480.052346] =A0c1c20d40 00000286 d0877650 00001000 c1c25200 c13ce= 460
> c13ce460 c1c20ef8
> [ =A0480.052367] =A0c26fb460 00000000 c1cd5600 c1cf02c0 cf4693ec cf576= 518
> c1005ff4 c26f0a5c
> [ =A0480.052387] =A0cf99fd98 cf99fdac c100665c c26f025c c1c20ef8 c26f0= a5c
> cf99fd98 cf99fdac
> [ =A0480.052407] Call Trace:
> [ =A0480.052418] =A0[<d0877650>] ? __ext3_get_inode_loc+0xc7/0x2= 75 [ext3]
> [ =A0480.052426] =A0[<c1005ff4>] ? xen_force_evtchn_callback+0xc= /0x10
> [ =A0480.052434] =A0[<c100665c>] ? check_events+0x8/0xc
> [ =A0480.052442] =A0[<d0845072>] ? do_get_write_access+0x1f8/0x3= b5 [jbd]
> [ =A0480.052450] =A0[<c104b97f>] ? wake_bit_function+0x0/0x3c > [ =A0480.052459] =A0[<d0845247>] ? journal_get_write_access+0x18= /0x26
> [jbd]
> [ =A0480.052469] =A0[<d0882caf>] ? __ext3_journal_get_write_acce= ss
> +0x13/0x32 [ext3]
> [ =A0480.052479] =A0[<d0877baf>] ? ext3_reserve_inode_write+0x2d= /0x5d
> [ext3]
> [ =A0480.052489] =A0[<d0877bf0>] ? ext3_mark_inode_dirty+0x11/0x= 27 [ext3]
> [ =A0480.052499] =A0[<d0877d05>] ? ext3_dirty_inode+0x50/0x63 [e= xt3]
> [ =A0480.052507] =A0[<c10cf541>] ? __mark_inode_dirty+0x20/0x10c=
> [ =A0480.052515] =A0[<c10c7bc5>] ? file_update_time+0xbe/0xdf > [ =A0480.052523] =A0[<c109107b>] ? __generic_file_aio_write+0x2f= 7/0x452
> [ =A0480.052531] =A0[<c1006653>] ? xen_restore_fl_direct_end+0x0= /0x1
> [ =A0480.052539] =A0[<c124f4ea>] ? _spin_unlock_irqrestore+0xe/0= x10
> [ =A0480.052546] =A0[<c104e617>] ? hrtimer_try_to_cancel+0x6e/0x= 83
> [ =A0480.052554] =A0[<c104e625>] ? hrtimer_try_to_cancel+0x7c/0x= 83
> [ =A0480.052561] =A0[<c1091227>] ? generic_file_aio_write+0x51/0= x93
> [ =A0480.052571] =A0[<c10b8680>] ? do_sync_write+0xc0/0x107
> [ =A0480.052578] =A0[<c104b952>] ? autoremove_wake_function+0x0/= 0x2d
> [ =A0480.052586] =A0[<c102dd9e>] ? pick_next_task_fair+0x95/0x9c=
> [ =A0480.052593] =A0[<c124e105>] ? schedule+0x5ea/0x671
> [ =A0480.052601] =A0[<c1107ae8>] ? security_file_permission+0xc/= 0xd
> [ =A0480.052609] =A0[<c10b85c0>] ? do_sync_write+0x0/0x107
> [ =A0480.052616] =A0[<c10b900b>] ? vfs_write+0x84/0x12f
> [ =A0480.052623] =A0[<c10b914e>] ? sys_write+0x3c/0x63
> [ =A0480.052630] =A0[<c10084b4>] ? sysenter_do_call+0x12/0x28 >
>
>
>
>
>



--000e0cd11096b9bf980482136b9b-- --===============0911257449== Content-Type: text/plain; charset="us-ascii" MIME-Version: 1.0 Content-Transfer-Encoding: 7bit Content-Disposition: inline _______________________________________________ Xen-devel mailing list Xen-devel@lists.xensource.com http://lists.xensource.com/xen-devel --===============0911257449==--