[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index] [Xen-devel] NMI on domU start with PCI passthrough, xen/master dom0, xen 3.5
I managed to get a xen/master & xen 3.5 unstable to NMI by attempting to pass through some PCIe devices. Details below. This is a dual CPU nehalem X58 chipset system. I will attempt to replicate with one PCI passthrough instead of 8. Please let me know what other information is needed. Thanks in advance. -Bruce (XEN) memory.c:126:d0 Could not allocate order=9 extent: id=2 memflags=0 (1 of 4) (XEN) memory.c:126:d0 Could not allocate order=9 extent: id=2 memflags=0 (0 of 4) (XEN) memory.c:126:d0 Could not allocate order=9 extent: id=2 memflags=0 (0 of 4) (XEN) memory.c:126:d0 Could not allocate order=9 extent: id=2 memflags=0 (0 of 4) (XEN) memory.c:126:d0 Could not allocate order=9 extent: id=2 memflags=0 (0 of 4) (XEN) memory.c:126:d0 Could not allocate order=9 extent: id=2 memflags=0 (0 of 3) (XEN) [VT-D]iommu.c:1289:d0 domain_context_unmap:PCIe: bdf = 7:0.0 (XEN) [VT-D]iommu.c:1175:d0 domain_context_mapping:PCIe: bdf = 7:0.0 (XEN) (XEN) (XEN) NMI - MEMORY ERROR (XEN) ----[ Xen-3.5-unstable x86_64 debug=y Not tainted ]---- (XEN) CPU: 0 (XEN) RIP: e008:[<ffff82c480137d96>] hvm_do_IRQ_dpci+0x5e/0xab (XEN) RFLAGS: 0000000000000002 CONTEXT: hypervisor (XEN) rax: 0000000000000001 rbx: ffff83031fe7c000 rcx: 0000000000000001 (XEN) rdx: 0000000000000082 rsi: 000000000000011f rdi: ffff83031ff82138 (XEN) rbp: ffff82c4802e7b88 rsp: ffff82c4802e7b68 r8: ffff82c4802e7f28 (XEN) r9: ffff82c4802e7ee4 r10: 0000000000affb00 r11: 000000000000ffff (XEN) r12: 000000000000011f r13: 0000000000000000 r14: ffff83031fe64f70 (XEN) r15: 0000000000000000 cr0: 000000008005003b cr4: 00000000000026f0 (XEN) cr3: 00000002f6b08000 cr2: ffff8802df8c66c0 (XEN) ds: 0000 es: 0000 fs: 0000 gs: 0000 ss: 0000 cs: e008 (XEN) Xen stack trace from rsp=ffff82c4802e7b68: (XEN) ffff82c4802e7b88 ffff83031fe7c000 000000000000011f 0000000000000000 (XEN) ffff82c4802e7c38 ffff82c480155cdc ffff82c4802e7bc8 ffff83031fe7c000 (XEN) 0000000000000015 0000000000000000 0000000000000041 ffff83031ff82134 (XEN) 00000041802e7c68 ffff82c4802e7c68 00000000802e7c18 0000000000000000 (XEN) ffff83031ff82100 0000000000000104 ffff82c4802e7c98 ffff82c4802e7c98 (XEN) 9800000000000002 0000000000000004 0000000000000000 00000000803211f8 (XEN) 0000000080170000 ffff8300d652c000 00007d3b7fd18397 ffff82c48014f626 (XEN) ffff8300d652c000 0000000080170000 00000000803211f8 0000000000000000 (XEN) ffff82c4802e7cf8 0000000000000004 000000000000ffff 0000000000affb00 (XEN) ffff82c4802e7ee4 ffff82c4802e7f28 0000000000000000 0000000000000001 (XEN) 0000000000000cfc 0000000000000286 ffff82c48022d9a8 000000b200000000 (XEN) ffff82c48011da3d 000000000000e008 0000000000000286 ffff82c4802e7cf8 (XEN) 0000000000000000 0000000000000286 ffff82c4802e7d28 ffff82c480166729 (XEN) 0000000000000004 0000000000000cfc 0000000000000004 00000000803211f8 (XEN) ffff82c4802e7d68 ffff82c48016e36a 0000000000000cfc 0000000000000cfc (XEN) ffff82c4802e7f28 ffffffff813f4954 0000000000000008 ffff82c4802e7e88 (XEN) ffff82c4802e7f18 ffff82c480171c26 ffff83000000f800 0000000100007ff0 (XEN) ffff82c4802e7dd8 ffff82c48015b2e0 0000000000000001 ffff83031fe7c000 (XEN) 000000020001fd05 ffff82c4802e7eb8 ffff82c4802e7df8 ffff82f6003fa0a0 (XEN) ffff82c4802e7dd8 0000000000000000 ffff82c4802e7e38 ffff82c48015f3c2 (XEN) Xen call trace: (XEN) [<ffff82c480137d96>] hvm_do_IRQ_dpci+0x5e/0xab (XEN) [<ffff82c480155cdc>] do_IRQ+0x38a/0x690 (XEN) [<ffff82c48014f626>] common_interrupt+0x26/0x30 (XEN) [<ffff82c48011da3d>] _spin_unlock_irqrestore+0x22/0x24 (XEN) [<ffff82c480166729>] pci_conf_write+0x9d/0xb2 (XEN) [<ffff82c48016e36a>] guest_io_write+0x14d/0x19f (XEN) [<ffff82c480171c26>] do_general_protection+0x1e01/0x2ef3 (XEN) (XEN) (XEN) **************************************** (XEN) Panic on CPU 0: (XEN) FATAL TRAP: vector = 2 (nmi) (XEN) [error_code=0000] , IN INTERRUPT CONTEXT (XEN) **************************************** (XEN) (XEN) Reboot in five seconds... Xen cmdline (XEN) Xen version 3.5-unstable (bedge@xxxxxxxxxxx) (gcc version 4.3.3 (Ubuntu 4.3.3-5ubuntu4) ) Fri Oct 9 16:02:02 PDT 2009 (XEN) Latest ChangeSet: Thu Oct 08 09:24:32 2009 +0100 20296:1d7221667204 (XEN) Command line: com1=115200,8n1 console=com1 loglvl=all loglvl_guest=all dom0_max_vcpus=1 dom0_vcpus_pin=true iommu=1,passthrough dom0 cndline [ 0.000000] Linux version 2.6.31.1 (root@kaan) (gcc version 4.3.3 (Ubuntu 4.3.3-5ubuntu4) ) #1 SMP Sat Oct 10 12:43:06 PDT 2009 [ 0.000000] Command line: root=UUID=e0a8abaf-ebb4-4a46-a968-36764653b87f ro earlyprintk=xen irqpoll console=hvc0 loglevel=10 debug acpi=force Devices to passthrough: 07:00.0 Fibre Channel: PMC-Sierra Inc. Device 8032 (rev 05) 07:00.1 Fibre Channel: PMC-Sierra Inc. Device 8032 (rev 05) 07:00.2 Fibre Channel: PMC-Sierra Inc. Device 8032 (rev 05) 07:00.3 Fibre Channel: PMC-Sierra Inc. Device 8032 (rev 05) 14:00.0 Fibre Channel: PMC-Sierra Inc. Device 8032 (rev 05) 14:00.1 Fibre Channel: PMC-Sierra Inc. Device 8032 (rev 05) 17:00.0 Fibre Channel: PMC-Sierra Inc. Device 8032 (rev 05) 17:00.1 Fibre Channel: PMC-Sierra Inc. Device 8032 (rev 05) lspci -vv -s 17:00.0: 17:00.0 Fibre Channel: PMC-Sierra Inc. Device 8032 (rev 05) Subsystem: Atto Technology Device 003b Control: I/O+ Mem+ BusMaster+ SpecCycle- MemWINV- VGASnoop- ParErr+ Stepping- SERR- FastB2B- DisINTx- Status: Cap+ 66MHz- UDF- FastB2B- ParErr- DEVSEL=fast >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx- Latency: 0, Cache Line Size: 64 bytes Interrupt: pin A routed to IRQ 7 Region 0: Memory at fbf00000 (64-bit, non-prefetchable) [size=1M] Region 2: I/O ports at 8000 [size=256] Region 3: I/O ports at 8400 [size=256] Region 4: Memory at fbef0000 (64-bit, non-prefetchable) [size=32K] [virtual] Expansion ROM at e4300000 [disabled] [size=1M] Capabilities: [50] Power Management version 3 Flags: PMEClk- DSI- D1- D2- AuxCurrent=0mA PME(D0-,D1-,D2-,D3hot-,D3cold-) Status: D0 PME-Enable- DSel=0 DScale=0 PME- Capabilities: [60] Message Signalled Interrupts: Mask- 64bit+ Queue=0/1 Enable- Address: 0000000000000000 Data: 0000 Capabilities: [70] Express (v2) Endpoint, MSI 01 DevCap: MaxPayload 4096 bytes, PhantFunc 0, Latency L0s <4us, L1 unlimited ExtTag- AttnBtn- AttnInd- PwrInd- RBE+ FLReset- DevCtl: Report errors: Correctable- Non-Fatal+ Fatal+ Unsupported- RlxdOrd+ ExtTag- PhantFunc- AuxPwr- NoSnoop- MaxPayload 256 bytes, MaxReadReq 4096 bytes DevSta: CorrErr+ UncorrErr- FatalErr- UnsuppReq+ AuxPwr- TransPend- LnkCap: Port #0, Speed 5GT/s, Width x8, ASPM L0s L1, Latency L0 <2us, L1 <4us ClockPM- Suprise- LLActRep- BwNot- LnkCtl: ASPM Disabled; RCB 64 bytes Disabled- Retrain- CommClk- ExtSynch- ClockPM- AutWidDis- BWInt- AutBWInt- LnkSta: Speed 2.5GT/s, Width x4, TrErr- Train- SlotClk+ DLActive- BWMgmt- ABWMgmt- Capabilities: [b0] MSI-X: Enable- Mask- TabSize=9 Vector table: BAR=4 offset=00004100 PBA: BAR=4 offset=00004000 Capabilities: [100] Advanced Error Reporting <?> Prior to starting domU: #> xm pci-list-assignable-devices 0000:17:00.0 0000:17:00.1 0000:14:00.0 0000:14:00.1 0000:07:00.0 0000:07:00.1 0000:07:00.2 0000:07:00.3 I was tailing /var/log/xen/*.log at the time and here's what was flushed out before the NMI: ==> xend.log <== [2009-10-13 08:31:16 2903] INFO (XendDomainInfo:1961) Domain has shutdown: name=dpm id=1 reason=poweroff. [2009-10-13 08:31:16 2903] DEBUG (XendDomainInfo:2844) XendDomainInfo.destroy: domid=1 [2009-10-13 08:31:17 2903] DEBUG (XendDomainInfo:2279) Destroying device model [2009-10-13 08:31:17 2903] INFO (image:586) dpm device model terminated [2009-10-13 08:31:17 2903] DEBUG (XendDomainInfo:2286) Releasing devices [2009-10-13 08:31:17 2903] DEBUG (XendDomainInfo:2292) Removing vif/0 [2009-10-13 08:31:17 2903] DEBUG (XendDomainInfo:1185) XendDomainInfo.destroyDevice: deviceClass = vif, device = vif/0 [2009-10-13 08:31:17 2903] DEBUG (XendDomainInfo:2292) Removing console/0 [2009-10-13 08:31:17 2903] DEBUG (XendDomainInfo:1185) XendDomainInfo.destroyDevice: deviceClass = console, device = console/0 [2009-10-13 08:31:18 2903] DEBUG (XendDomainInfo:2292) Removing vbd/51712 [2009-10-13 08:31:18 2903] DEBUG (XendDomainInfo:1185) XendDomainInfo.destroyDevice: deviceClass = vbd, device = vbd/51712 [2009-10-13 08:31:18 2903] DEBUG (XendDomainInfo:2292) Removing vbd/51728 [2009-10-13 08:31:18 2903] DEBUG (XendDomainInfo:1185) XendDomainInfo.destroyDevice: deviceClass = vbd, device = vbd/51728 [2009-10-13 08:31:18 2903] DEBUG (XendDomainInfo:2292) Removing vfb/0 [2009-10-13 08:31:18 2903] DEBUG (XendDomainInfo:1185) XendDomainInfo.destroyDevice: deviceClass = vfb, device = vfb/0 [2009-10-13 08:32:03 2903] DEBUG (XendDomainInfo:99) XendDomainInfo.create(['vm', ['name', 'dpm'], ['memory', 4096], ['on_poweroff', 'destroy'], ['on_reboot', 'restart'], ['on_crash', 'restart'], ['vcpus', 1], ['on_xend_start', 'ignore'] , ['on_xend_stop', 'ignore'], ['bootloader', '/usr/bin/pygrub'], ['bootloader_args', ''], ['image', ['hvm', ['kernel', '/usr/lib64/xen/boot/hvmloader'], ['videoram', 4], ['device_model', '/usr/lib64/xen/bin/qemu-dm'], ['pae', 1], ['vcpus ', 1], ['boot', 'c'], ['fda', ''], ['fdb', ''], ['timer_mode', 1], ['localtime', 0], ['serial', 'pty'], ['stdvga', 0], ['isa', 0], ['nographic', 0], ['soundhw', ''], ['vnc', 1], ['vncunused', 1], ['vncconsole', 1], ['vnclisten', '0.0.0.0 '], ['sdl', 0], ['xauthority', '/root/.Xauthority'], ['rtc_timeoffset', 0], ['monitor', 0], ['acpi', 1], ['apic', 1], ['usb', 0], ['usbdevice', 'tablet'], ['keymap', ''], ['pci', [['0x0000', '0x07', '0x00', '0x0', '0x100', [], '07:00.0'] , ['0x0000', '0x07', '0x00', '0x1', '0x100', [], '07:00.1'], ['0x0000', '0x07', '0x00', '0x2', '0x100', [], '07:00.2'], ['0x0000', '0x07', '0x00', '0x3', '0x100', [], '07:00.3'], ['0x0000', '0x14', '0x00', '0x0', '0x100', [], '14:00.0'], ['0x0000', '0x14', '0x00', '0x1', '0x100', [], '14:00.1'], ['0x0000', '0x17', '0x00', '0x0', '0x100', [], '17:00.0'], ['0x0000', '0x17', '0x00', '0x1', '0x100', [], '17:00.1']]], ['hpet', 0], ['guest_os_type', 'default'], ['hap', 0], [' cpuid', []], ['cpuid_check', []], ['viridian', 0], ['pci_msitranslate', 1], ['vpt_align', 1], ['pci_power_mgmt', 0], ['xen_platform_pci', 1], ['vncpasswd', 'XXXXXXXX'], ['tsc_native', 0]]], ['s3_integrity', 1], ['device', ['vbd', ['uname ', 'phy:system/dpm_root_0'], ['dev', 'xvda:sda1'], ['mode', 'w']]], ['device', ['vbd', ['uname', 'phy:system/dpm_swap'], ['dev', 'xvdb:sda2'], ['mode', 'w']]], ['device', ['pci', ['dev', ['slot', '0x00'], ['domain', '0x0000'], ['key', '0 7:00.0'], ['bus', '0x07'], ['vdevfn', '0x100'], ['func', '0x0']], ['dev', ['slot', '0x00'], ['domain', '0x0000'], ['key', '07:00.1'], ['bus', '0x07'], ['vdevfn', '0x100'], ['func', '0x1']], ['dev', ['slot', '0x00'], ['domain', '0x0000'], ['key', '07:00.2'], ['bus', '0x07'], ['vdevfn', '0x100'], ['func', '0x2']], ['dev', ['slot', '0x00'], ['domain', '0x0000'], ['key', '07:00.3'], ['bus', '0x07'], ['vdevfn', '0x100'], ['func', '0x3']], ['dev', ['slot', '0x00'], ['domain', '0x0000'], ['key', '14:00.0'], ['bus', '0x14'], ['vdevfn', '0x100'], ['func', '0x0']], ['dev', ['slot', '0x00'], ['domain', '0x0000'], ['key', '14:00.1'], ['bus', '0x14'], ['vdevfn', '0x100'], ['func', '0x1']], ['dev', ['slot', '0x00'], ['domain', '0x0000'], ['key', '17:00.0'], ['bus', '0x17'], ['vdevfn', '0x100'], ['func', '0x0']], ['dev', ['slot', '0x00'], ['domain', '0x0000'], ['key', '17:00.1'], ['bus', '0x17'], ['vdevfn', '0x100'], ['func', '0x1']]]], ['device', [ 'vif', ['bridge', 'eth0'], ['model', 'e1000'], ['mac', '00:16:3e:00:14:01']]]]) [2009-10-13 08:32:03 2903] DEBUG (XendDomainInfo:2369) XendDomainInfo.constructDomain [2009-10-13 08:32:03 2903] DEBUG (balloon:181) Balloon: 4234496 KiB free; need 4096; done. [2009-10-13 08:32:03 2903] DEBUG (XendDomain:454) Adding Domain: 2 [2009-10-13 08:32:03 2903] DEBUG (XendDomainInfo:2614) XendDomainInfo.initDomain: 2 256 [2009-10-13 08:32:04 2903] DEBUG (image:338) No VNC passwd configured for vfb access [2009-10-13 08:32:04 2903] DEBUG (image:843) args: boot, val: c [2009-10-13 08:32:04 2903] DEBUG (image:843) args: fda, val: None [2009-10-13 08:32:04 2903] DEBUG (image:843) args: fdb, val: None [2009-10-13 08:32:04 2903] DEBUG (image:843) args: soundhw, val: None [2009-10-13 08:32:04 2903] DEBUG (image:843) args: localtime, val: 0 [2009-10-13 08:32:04 2903] DEBUG (image:843) args: serial, val: ['pty'] [2009-10-13 08:32:04 2903] DEBUG (image:843) args: std-vga, val: 0 [2009-10-13 08:32:04 2903] DEBUG (image:843) args: isa, val: 0 [2009-10-13 08:32:04 2903] DEBUG (image:843) args: acpi, val: 1 [2009-10-13 08:32:04 2903] DEBUG (image:843) args: usb, val: 0 [2009-10-13 08:32:04 2903] DEBUG (image:843) args: usbdevice, val: tablet [2009-10-13 08:32:04 2903] DEBUG (image:843) args: gfx_passthru, val: None [2009-10-13 08:32:04 2903] INFO (image:779) Need to create platform device.[domid:2] [2009-10-13 08:32:04 2903] DEBUG (XendDomainInfo:2641) _initDomain:shadow_memory=0x0, memory_static_max=0x100000000, memory_static_min=0x0. [2009-10-13 08:32:04 2903] DEBUG (balloon:135) Balloon: tmem relinquished -1 KiB of 15536 KiB requested. [2009-10-13 08:32:04 2903] DEBUG (balloon:187) Balloon: 4233040 KiB free; 0 to scrub; need 4248576; retries: 20. [2009-10-13 08:32:04 2903] DEBUG (balloon:202) Balloon: setting dom0 target to 7986 MiB. [2009-10-13 08:32:04 2903] DEBUG (XendDomainInfo:1369) Setting memory target of domain Domain-0 (0) to 7986 MiB. [2009-10-13 08:32:04 2903] DEBUG (balloon:181) Balloon: 4249424 KiB free; need 4248576; done. [2009-10-13 08:32:04 2903] INFO (image:181) buildDomain os=hvm dom=2 vcpus=1 [2009-10-13 08:32:04 2903] DEBUG (image:896) domid = 2 [2009-10-13 08:32:04 2903] DEBUG (image:897) image = /usr/lib64/xen/boot/hvmloader [2009-10-13 08:32:04 2903] DEBUG (image:898) store_evtchn = 2 [2009-10-13 08:32:04 2903] DEBUG (image:899) memsize = 4096 [2009-10-13 08:32:04 2903] DEBUG (image:900) target = 4096 [2009-10-13 08:32:04 2903] DEBUG (image:901) vcpus = 1 [2009-10-13 08:32:04 2903] DEBUG (image:902) acpi = 1 [2009-10-13 08:32:04 2903] DEBUG (image:903) apic = 1 [2009-10-13 08:32:04 2903] INFO (XendDomainInfo:2240) createDevice: vfb : {'vncunused': 1, 'vnclisten': '0.0.0.0', 'vnc': '1', 'uuid': '87ec5ba7-11fd-f2fc-7fe0-3011a9d9ef44', 'other_config': {'vncunused': 1, 'vnclisten': '0.0.0.0', 'vnc' : '1'}} [2009-10-13 08:32:04 2903] DEBUG (DevController:95) DevController: writing {'state': '1', 'backend-id': '0', 'backend': '/local/domain/0/backend/vfb/2/0'} to /local/domain/2/device/vfb/0. [2009-10-13 08:32:04 2903] DEBUG (DevController:97) DevController: writing {'vncunused': '1', 'domain': 'dpm', 'frontend': '/local/domain/2/device/vfb/0', 'uuid': '87ec5ba7-11fd-f2fc-7fe0-3011a9d9ef44', 'frontend-id': '2', 'vnclisten': ' 0.0.0.0', 'state': '1', 'online': '1', 'vnc': '1'} to /local/domain/0/backend/vfb/2/0. [2009-10-13 08:32:04 2903] INFO (XendDomainInfo:2240) createDevice: vbd : {'uuid': '02bfe483-9b60-af38-3ee5-08fd59f3adc9', 'bootable': 1, 'driver': 'paravirtualised', 'dev': 'xvda:sda1', 'uname': 'phy:system/dpm_root_0', 'mode': 'w'} [2009-10-13 08:32:04 2903] DEBUG (DevController:95) DevController: writing {'backend-id': '0', 'virtual-device': '51712', 'device-type': 'sda1', 'state': '1', 'backend': '/local/domain/0/backend/vbd/2/51712'} to /local/domain/2/device/vb d/51712. [2009-10-13 08:32:04 2903] DEBUG (DevController:97) DevController: writing {'domain': 'dpm', 'frontend': '/local/domain/2/device/vbd/51712', 'uuid': '02bfe483-9b60-af38-3ee5-08fd59f3adc9', 'bootable': '1', 'dev': 'xvda', 'state': '1', 'p arams': 'system/dpm_root_0', 'mode': 'w', 'online': '1', 'frontend-id': '2', 'type': 'phy'} to /local/domain/0/backend/vbd/2/51712. [2009-10-13 08:32:05 2903] INFO (XendDomainInfo:2240) createDevice: vbd : {'uuid': '4d6cf39a-8720-8672-de5a-5a5295baefc7', 'bootable': 0, 'driver': 'paravirtualised', 'dev': 'xvdb:sda2', 'uname': 'phy:system/dpm_swap', 'mode': 'w'} [2009-10-13 08:32:05 2903] DEBUG (DevController:95) DevController: writing {'backend-id': '0', 'virtual-device': '51728', 'device-type': 'sda2', 'state': '1', 'backend': '/local/domain/0/backend/vbd/2/51728'} to /local/domain/2/device/vb d/51728. [2009-10-13 08:32:05 2903] DEBUG (DevController:97) DevController: writing {'domain': 'dpm', 'frontend': '/local/domain/2/device/vbd/51728', 'uuid': '4d6cf39a-8720-8672-de5a-5a5295baefc7', 'bootable': '0', 'dev': 'xvdb', 'state': '1', 'p arams': 'system/dpm_swap', 'mode': 'w', 'online': '1', 'frontend-id': '2', 'type': 'phy'} to /local/domain/0/backend/vbd/2/51728. [2009-10-13 08:32:05 2903] INFO (XendDomainInfo:2240) createDevice: vif : {'bridge': 'eth0', 'model': 'e1000', 'mac': '00:16:3e:00:14:01', 'uuid': '2c93f5d3-5aa0-0802-d5d8-71926d329433'} [2009-10-13 08:32:05 2903] DEBUG (DevController:95) DevController: writing {'backend-id': '0', 'mac': '00:16:3e:00:14:01', 'handle': '0', 'state': '1', 'backend': '/local/domain/0/backend/vif/2/0'} to /local/domain/2/device/vif/0. [2009-10-13 08:32:05 2903] DEBUG (DevController:97) DevController: writing {'bridge': 'eth0', 'domain': 'dpm', 'handle': '0', 'uuid': '2c93f5d3-5aa0-0802-d5d8-71926d329433', 'script': '/etc/xen/scripts/vif-bridge', 'mac': '00:16:3e:00:14 :01', 'frontend-id': '2', 'state': '1', 'online': '1', 'frontend': '/local/domain/2/device/vif/0', 'model': 'e1000'} to /local/domain/0/backend/vif/2/0. [2009-10-13 08:32:05 2903] INFO (XendDomainInfo:2240) createDevice: pci : {'devs': [{'slot': '0x00', 'domain': '0x0000', 'key': '07:00.0', 'bus': '0x07', 'vdevfn': '0x100', 'func': '0x0', 'uuid': '5e3d06bc-c314-fd29-298d-2b658c8e397a'}, {'slot': '0x00', 'domain': '0x0000', 'key': '07:00.1', 'bus': '0x07', 'vdevfn': '0x100', 'func': '0x1', 'uuid': '3b48c14f-4a39-e146-44cd-78d7a62a191a'}, {'slot': '0x00', 'domain': '0x0000', 'key': '07:00.2', 'bus': '0x07', 'vdevfn': '0x1 00', 'func': '0x2', 'uuid': '020d04bd-516f-0a9b-a344-f1c306a28c18'}, {'slot': '0x00', 'domain': '0x0000', 'key': '07:00.3', 'bus': '0x07', 'vdevfn': '0x100', 'func': '0x3', 'uuid': 'b0fd8c7e-c2ee-993e-f14e-0881368d8795'}, {'slot': '0x00' , 'domain': '0x0000', 'key': '14:00.0', 'bus': '0x14', 'vdevfn': '0x100', 'func': '0x0', 'uuid': 'a76dc4b6-bf90-3812-8c6e-be9e888bf47b'}, {'slot': '0x00', 'domain': '0x0000', 'key': '14:00.1', 'bus': '0x14', 'vdevfn': '0x100', 'func': '0 x1', 'uuid': '912b3f64-57a3-aab4-252f-1f90950b8254'}, {'slot': '0x00', 'domain': '0x0000', 'key': '17:00.0', 'bus': '0x17', 'vdevfn': '0x100', 'func': '0x0', 'uuid': '69eb1d4e-82bc-82b6-e754-f08714adcc01'}, {'slot': '0x00', 'domain': '0x 0000', 'key': '17:00.1', 'bus': '0x17', 'vdevfn': '0x100', 'func': '0x1', 'uuid': '58675104-bdda-4239-9a25-9f4bf8578c02'}], 'uuid': '4d92ccdb-ddd1-44e8-91b4-aaa22b6264d4'} ==> xend.log <== [2009-10-13 08:32:06 2903] DEBUG (pciif:446) pci: register aer watch /local/domain/0/backend/pci/2/0/aerState [2009-10-13 08:32:06 2903] DEBUG (DevController:95) DevController: writing {'state': '1', 'backend-id': '0', 'backend': '/local/domain/0/backend/pci/2/0'} to /local/domain/2/device/pci/0. [2009-10-13 08:32:06 2903] DEBUG (DevController:97) DevController: writing {'key-3': '07:00.3', 'key-2': '07:00.2', 'key-1': '07:00.1', 'key-0': '07:00.0', 'key-7': '17:00.1', 'key-6': '17:00.0', 'key-5': '14:00.1', 'key-4': '14:00.0', ' domain': 'dpm', 'frontend': '/local/domain/2/device/pci/0', 'uuid-4': 'a76dc4b6-bf90-3812-8c6e-be9e888bf47b', 'uuid-5': '912b3f64-57a3-aab4-252f-1f90950b8254', 'uuid-6': '69eb1d4e-82bc-82b6-e754-f08714adcc01', 'uuid-7': '58675104-bdda-42 39-9a25-9f4bf8578c02', 'uuid-0': '5e3d06bc-c314-fd29-298d-2b658c8e397a', 'uuid-1': '3b48c14f-4a39-e146-44cd-78d7a62a191a', 'uuid-2': '020d04bd-516f-0a9b-a344-f1c306a28c18', 'uuid-3': 'b0fd8c7e-c2ee-993e-f14e-0881368d8795', 'uuid': '4d92c cdb-ddd1-44e8-91b4-aaa22b6264d4', 'state': '1', 'online': '1', 'power_mgmt': '0', 'dev-3': '0000:07:00.3', 'dev-2': '0000:07:00.2', 'dev-1': '0000:07:00.1', 'dev-0': '0000:07:00.0', 'dev-7': '0000:17:00.1', 'dev-6': '0000:17:00.0', 'dev- 5': '0000:14:00.1', 'dev-4': '0000:14:00.0', 'msitranslate': '1', 'vdevfn-4': '100', 'vdevfn-5': '100', 'vdevfn-6': '100', 'vdevfn-7': '100', 'vdevfn-0': '100', 'vdevfn-1': '100', 'vdevfn-2': '100', 'vdevfn-3': '100', 'frontend-id': '2', 'num_devs': '8'} to /local/domain/0/backend/pci/2/0. [2009-10-13 08:32:06 2903] INFO (image:410) spawning device models: /usr/lib64/xen/bin/qemu-dm ['/usr/lib64/xen/bin/qemu-dm', '-d', '2', '-domain-name', 'dpm', '-videoram', '4', '-vnc', '0.0.0.0:0', '-vncunused', '-vcpus', '1', '-boot', 'c', '-serial', 'pty', '-acpi', '-usbdevice', 'tablet', '-net', 'nic,vlan=1,macaddr=00:16:3e:00:14:01,model=e1000', '-net', 'tap,vlan=1,ifname=tap2.0,bridge=eth0', '-M', 'xenfv'] [2009-10-13 08:32:06 2903] INFO (image:459) device model pid: 14802 [2009-10-13 08:32:06 2903] DEBUG (XendDomainInfo:840) XendDomainInfo.pci_device_configure: ['pci', ['dev', ['slot', '0x00'], ['domain', '0x0000'], ['key', '07:00.0'], ['bus', '0x07'], ['vdevfn', '0x100'], ['func', '0x0'], ['uuid', '5e3d0 6bc-c314-fd29-298d-2b658c8e397a']], ['state', 'Initialising'], ['sub_state', 'Booting']] [2009-10-13 08:32:06 2903] DEBUG (XendDomainInfo:743) XendDomainInfo.hvm_pci_device_insert: {'devs': [{'slot': '0x00', 'domain': '0x0000', 'key': '07:00.0', 'bus': '0x07', 'vdevfn': '0x100', 'func': '0x0', 'uuid': '5e3d06bc-c314-fd29-298 d-2b658c8e397a'}], 'states': ['Initialising']} [2009-10-13 08:32:06 2903] DEBUG (XendDomainInfo:754) XendDomainInfo.hvm_pci_device_insert_dev: {'slot': '0x00', 'domain': '0x0000', 'key': '07:00.0', 'bus': '0x07', 'vdevfn': '0x100', 'func': '0x0', 'uuid': '5e3d06bc-c314-fd29-298d-2b65 8c8e397a'} [2009-10-13 08:32:06 2903] DEBUG (XendDomainInfo:763) XendDomainInfo.hvm_pci_device_insert_dev: 0000:07:00.0@100 [2009-10-13 08:32:06 2903] INFO (image:561) waiting for sentinel_fifo [2009-10-13 08:32:06 2903] DEBUG (image:479) signalDeviceModel: orig_state is None, retrying [2009-10-13 08:32:07 2903] WARNING (image:523) domain dpm: device model failure: pid 14802: exited with nonzero status 1; see /var/log/xen/qemu-dm-dpm.log [2009-10-13 08:32:17 2903] ERROR (XendDomainInfo:2694) XendDomainInfo.initDomain: exception occurred Traceback (most recent call last): File "/usr/local/lib/python2.6/dist-packages/xen/xend/XendDomainInfo.py", line 2686, in _initDomain self._createDevices() File "/usr/local/lib/python2.6/dist-packages/xen/xend/XendDomainInfo.py", line 2273, in _createDevices self.pci_device_configure_boot() File "/usr/local/lib/python2.6/dist-packages/xen/xend/XendDomainInfo.py", line 620, in pci_device_configure_boot self.pci_device_configure(dev_sxp) File "/usr/local/lib/python2.6/dist-packages/xen/xend/XendDomainInfo.py", line 863, in pci_device_configure vdevfn = self.hvm_pci_device_insert(dev_config) File "/usr/local/lib/python2.6/dist-packages/xen/xend/XendDomainInfo.py", line 750, in hvm_pci_device_insert return self.hvm_pci_device_insert_dev(new_dev) File "/usr/local/lib/python2.6/dist-packages/xen/xend/XendDomainInfo.py", line 764, in hvm_pci_device_insert_dev self.image.signalDeviceModel('pci-ins', 'pci-inserted', bdf_str) File "/usr/local/lib/python2.6/dist-packages/xen/xend/image.py", line 504, in signalDeviceModel raise VmError('Timed out waiting for device model action') VmError: Timed out waiting for device model action [2009-10-13 08:32:17 2903] ERROR (XendDomainInfo:467) VM start failed Traceback (most recent call last): File "/usr/local/lib/python2.6/dist-packages/xen/xend/XendDomainInfo.py", line 453, in start XendTask.log_progress(31, 60, self._initDomain) File "/usr/local/lib/python2.6/dist-packages/xen/xend/XendTask.py", line 209, in log_progress retval = func(*args, **kwds) File "/usr/local/lib/python2.6/dist-packages/xen/xend/XendDomainInfo.py", line 2697, in _initDomain raise exn VmError: Timed out waiting for device model action [2009-10-13 08:32:17 2903] DEBUG (XendDomainInfo:2844) XendDomainInfo.destroy: domid=2 _______________________________________________ Xen-devel mailing list Xen-devel@xxxxxxxxxxxxxxxxxxx http://lists.xensource.com/xen-devel
|
Lists.xenproject.org is hosted with RackSpace, monitoring our |