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
|
Home