[fedora-virt] internal error unable to reserve PCI address.." - with virt-preview pkgs
Kashyap Chamarthy
kashyapc at fedoraproject.org
Mon Sep 19 12:36:44 UTC 2011
Hi,
I created a bunch of guests, and then updated to virt-preview packages, now I can't seem
to start those guests. (This is on F15)
##########################################
[root at moon ~]# rpm -q libvirt
libvirt-0.9.4-1.fc15.x86_64
[root at moon ~]#
##########################################
[root at moon ~]# virsh list --all
Id Name State
----------------------------------
- f15vm1 shut off
- f15vm2 shut off
##########################################
[root at moon ~]# virsh start f15vm2
error: Failed to start domain f15vm2
error: internal error unable to reserve PCI address 0:0:2.0
[root at moon ~]#
##########################################
At the moment, I'll downgrade to the stable version on F15 for further testing.
Output w/ LIBVIRT_DEBUG=1
##############################################################################
17:29:25.348: 25695: info : libvirt version: 0.9.4, package: 1.fc15 (Unknown,
2011-08-15-16:38:49, fedora64.linuxtx.org)
17:29:25.348: 25695: debug : virInitialize:412 : register drivers
17:29:25.348: 25695: debug : virRegisterDriver:767 : driver=0x7ff0065d6ec0 name=Test
17:29:25.348: 25695: debug : virRegisterDriver:791 : registering Test as driver 0
17:29:25.348: 25695: debug : virRegisterNetworkDriver:584 : registering Test as network
driver 0
17:29:25.348: 25695: debug : virRegisterInterfaceDriver:617 : registering Test as
interface driver 0
17:29:25.348: 25695: debug : virRegisterStorageDriver:650 : registering Test as storage
driver 0
17:29:25.348: 25695: debug : virRegisterDeviceMonitor:683 : registering Test as device
driver 0
17:29:25.348: 25695: debug : virRegisterSecretDriver:716 : registering Test as secret driver 0
17:29:25.348: 25695: debug : virRegisterNWFilterDriver:749 : registering Test as network
filter driver 0
17:29:25.349: 25695: debug : virRegisterDriver:767 : driver=0x7ff0065d81a0 name=Xen
17:29:25.349: 25695: debug : virRegisterDriver:791 : registering Xen as driver 1
17:29:25.349: 25695: debug : virRegisterDriver:767 : driver=0x7ff0065d8fc0 name=OPENVZ
17:29:25.349: 25695: debug : virRegisterDriver:791 : registering OPENVZ as driver 2
17:29:25.349: 25695: debug : virRegisterDriver:767 : driver=0x7ff0065d9420 name=VMWARE
17:29:25.349: 25695: debug : virRegisterDriver:791 : registering VMWARE as driver 3
17:29:25.349: 25695: debug : virRegisterDriver:767 : driver=0x7ff0065d8980 name=PHYP
17:29:25.349: 25695: debug : virRegisterDriver:791 : registering PHYP as driver 4
17:29:25.349: 25695: debug : virRegisterStorageDriver:650 : registering PHYP as storage
driver 1
17:29:25.349: 25695: debug : virRegisterInterfaceDriver:617 : registering PHYP as
interface driver 1
17:29:25.349: 25695: debug : vboxRegister:130 : VBoxCGlueInit failed, using dummy driver
17:29:25.349: 25695: debug : virRegisterDriver:767 : driver=0x7ff0065d9880 name=VBOX
17:29:25.349: 25695: debug : virRegisterDriver:791 : registering VBOX as driver 5
17:29:25.349: 25695: debug : virRegisterNetworkDriver:584 : registering VBOX as network
driver 1
17:29:25.349: 25695: debug : virRegisterStorageDriver:650 : registering VBOX as storage
driver 2
17:29:25.349: 25695: debug : virRegisterDriver:767 : driver=0x7ff0065dbc20 name=ESX
17:29:25.349: 25695: debug : virRegisterDriver:791 : registering ESX as driver 6
17:29:25.349: 25695: debug : virRegisterInterfaceDriver:617 : registering ESX as interface
driver 2
17:29:25.349: 25695: debug : virRegisterNetworkDriver:584 : registering ESX as network
driver 2
17:29:25.349: 25695: debug : virRegisterStorageDriver:650 : registering ESX as storage
driver 3
17:29:25.349: 25695: debug : virRegisterDeviceMonitor:683 : registering ESX as device driver 1
17:29:25.349: 25695: debug : virRegisterSecretDriver:716 : registering ESX as secret driver 1
17:29:25.349: 25695: debug : virRegisterNWFilterDriver:749 : registering ESX as network
filter driver 1
17:29:25.349: 25695: debug : virRegisterDriver:767 : driver=0x7ff0065d76c0 name=remote
17:29:25.349: 25695: debug : virRegisterDriver:791 : registering remote as driver 7
17:29:25.349: 25695: debug : virRegisterNetworkDriver:584 : registering remote as network
driver 3
17:29:25.349: 25695: debug : virRegisterInterfaceDriver:617 : registering remote as
interface driver 3
17:29:25.349: 25695: debug : virRegisterStorageDriver:650 : registering remote as storage
driver 4
17:29:25.349: 25695: debug : virRegisterDeviceMonitor:683 : registering remote as device
driver 2
17:29:25.349: 25695: debug : virRegisterSecretDriver:716 : registering remote as secret
driver 2
17:29:25.349: 25695: debug : virRegisterNWFilterDriver:749 : registering remote as network
filter driver 2
17:29:25.349: 25695: debug : virEventRegisterDefaultImpl:204 : registering default event
implementation
17:29:25.349: 25695: debug : virEventPollAddHandle:112 : Add handle fd=3 events=1
cb=0x7ff0061b0900 opaque=(nil)
17:29:25.349: 25695: debug : virEventPollAddHandle:116 : Used 0 handle slots, adding at
least 10 more
17:29:25.349: 25695: debug : virEventPollInterruptLocked:676 : Skip interrupt, 0 0
17:29:25.349: 25695: debug : virEventRegisterImpl:177 : addHandle=0x7ff0061b12f0
updateHandle=0x7ff0061b11f0 removeHandle=0x7ff0061b0ca0 addTimeout=0x7ff0061b0de0
updateTimeout=0x7ff0061b0f70 removeTimeout=0x7ff0061b1080
17:29:25.349: 25695: debug : virConnectOpenAuth:1279 : name=(null), auth=0x7ff0065d6e40,
flags=0
17:29:25.349: 25695: debug : do_open:1016 : no name, allowing driver auto-select
17:29:25.349: 25695: debug : do_open:1053 : trying driver 0 (Test) ...
17:29:25.349: 25695: debug : do_open:1059 : driver 0 Test returned DECLINED
17:29:25.349: 25695: debug : do_open:1053 : trying driver 1 (Xen) ...
17:29:25.349: 25695: debug : do_open:1059 : driver 1 Xen returned DECLINED
17:29:25.349: 25695: debug : do_open:1053 : trying driver 2 (OPENVZ) ...
17:29:25.349: 25695: debug : do_open:1059 : driver 2 OPENVZ returned DECLINED
17:29:25.349: 25695: debug : do_open:1053 : trying driver 3 (VMWARE) ...
17:29:25.349: 25695: debug : do_open:1059 : driver 3 VMWARE returned DECLINED
17:29:25.349: 25695: debug : do_open:1053 : trying driver 4 (PHYP) ...
17:29:25.349: 25695: debug : do_open:1059 : driver 4 PHYP returned DECLINED
17:29:25.349: 25695: debug : do_open:1053 : trying driver 5 (VBOX) ...
17:29:25.349: 25695: debug : do_open:1059 : driver 5 VBOX returned DECLINED
17:29:25.349: 25695: debug : do_open:1053 : trying driver 6 (ESX) ...
17:29:25.349: 25695: debug : do_open:1059 : driver 6 ESX returned DECLINED
17:29:25.349: 25695: debug : do_open:1053 : trying driver 7 (remote) ...
17:29:25.349: 25695: debug : remoteOpen:808 : Auto-probe remote URI
17:29:25.349: 25695: debug : doRemoteOpen:503 : proceeding with name =
17:29:25.349: 25695: debug : doRemoteOpen:513 : Connecting with transport 1
17:29:25.349: 25695: debug : doRemoteOpen:560 : Proceeding with sockname
/var/run/libvirt/libvirt-sock
17:29:25.350: 25695: debug : virNetSocketNew:115 : localAddr=0x7ffffc318a80
remoteAddr=0x7ffffc318b10 fd=5 errfd=-1 pid=0
17:29:25.350: 25695: debug : virNetSocketNew:173 : sock=0x15bf5e0 localAddrStr=127.0.0.1;0
remoteAddrStr=127.0.0.1;0
17:29:25.350: 25695: debug : virEventPollAddHandle:112 : Add handle fd=5 events=1
cb=0x7ff0062669b0 opaque=0x15bf5e0
17:29:25.350: 25695: debug : virEventPollInterruptLocked:676 : Skip interrupt, 0 0
17:29:25.350: 25695: debug : virNetClientNew:160 : client=0x7ff006797010 refs=2
17:29:25.350: 25695: debug : doRemoteOpen:640 : Trying authentication
17:29:25.350: 25695: debug : virNetMessageNew:44 : msg=0x7ff006756010
17:29:25.350: 25695: debug : virNetMessageEncodePayload:255 : Encode length as 28
17:29:25.350: 25695: debug : virNetClientIO:1035 : program=536903814 version=1 serial=0
proc=66 type=0 length=28 dispatch=(nil)
17:29:25.350: 25695: debug : virNetClientIO:1103 : We have the buck 0x15bf2f0 0x15bf2f0
17:29:25.350: 25695: debug : virEventPollUpdateHandle:145 : Update handle w=2 e=0
17:29:25.350: 25695: debug : virEventPollInterruptLocked:676 : Skip interrupt, 0 0
17:29:25.351: 25695: debug : virNetMessageDecodeLength:125 : Got length, now need 36 total
(32 more)
17:29:25.351: 25695: debug : virNetClientCallDispatch:662 : Incoming message prog
536903814 vers 1 proc 66 type 1 status 0 serial 0
17:29:25.351: 25695: debug : virNetClientIOEventLoop:958 : Giving up the buck 0x15bf2f0 (nil)
17:29:25.351: 25695: debug : virEventPollUpdateHandle:145 : Update handle w=2 e=1
17:29:25.351: 25695: debug : virEventPollInterruptLocked:676 : Skip interrupt, 0 0
17:29:25.351: 25695: debug : virNetClientIO:1130 : All done with our call (nil) 0x15bf2f0 0
17:29:25.351: 25695: debug : virNetMessageFree:57 : msg=0x7ff006756010
17:29:25.351: 25695: debug : doRemoteOpen:648 : Trying to open URI
17:29:25.351: 25695: debug : virNetMessageNew:44 : msg=0x15c1d90
17:29:25.351: 25695: debug : virNetMessageEncodePayload:255 : Encode length as 40
17:29:25.351: 25695: debug : virNetClientIO:1035 : program=536903814 version=1 serial=1
proc=1 type=0 length=40 dispatch=(nil)
17:29:25.351: 25695: debug : virNetClientIO:1103 : We have the buck 0x15bf2f0 0x15bf2f0
17:29:25.351: 25695: debug : virEventPollUpdateHandle:145 : Update handle w=2 e=0
17:29:25.351: 25695: debug : virEventPollInterruptLocked:676 : Skip interrupt, 0 0
17:29:25.358: 25695: debug : virNetMessageDecodeLength:125 : Got length, now need 28 total
(24 more)
17:29:25.358: 25695: debug : virNetClientCallDispatch:662 : Incoming message prog
536903814 vers 1 proc 1 type 1 status 0 serial 1
17:29:25.358: 25695: debug : virNetClientIOEventLoop:958 : Giving up the buck 0x15bf2f0 (nil)
17:29:25.358: 25695: debug : virEventPollUpdateHandle:145 : Update handle w=2 e=1
17:29:25.358: 25695: debug : virEventPollInterruptLocked:676 : Skip interrupt, 0 0
17:29:25.358: 25695: debug : virNetClientIO:1130 : All done with our call (nil) 0x15bf2f0 0
17:29:25.358: 25695: debug : virNetMessageFree:57 : msg=0x15c1d90
17:29:25.358: 25695: debug : doRemoteOpen:659 : Trying to query remote URI
17:29:25.358: 25695: debug : virNetMessageNew:44 : msg=0x15c1d90
17:29:25.358: 25695: debug : virNetMessageEncodePayload:255 : Encode length as 28
17:29:25.358: 25695: debug : virNetClientIO:1035 : program=536903814 version=1 serial=2
proc=110 type=0 length=28 dispatch=(nil)
17:29:25.358: 25695: debug : virNetClientIO:1103 : We have the buck 0x15bf2f0 0x15bf2f0
17:29:25.358: 25695: debug : virEventPollUpdateHandle:145 : Update handle w=2 e=0
17:29:25.358: 25695: debug : virEventPollInterruptLocked:676 : Skip interrupt, 0 0
17:29:25.359: 25695: debug : virNetMessageDecodeLength:125 : Got length, now need 48 total
(44 more)
17:29:25.359: 25695: debug : virNetClientCallDispatch:662 : Incoming message prog
536903814 vers 1 proc 110 type 1 status 0 serial 2
17:29:25.359: 25695: debug : virNetClientIOEventLoop:958 : Giving up the buck 0x15bf2f0 (nil)
17:29:25.359: 25695: debug : virEventPollUpdateHandle:145 : Update handle w=2 e=1
17:29:25.359: 25695: debug : virEventPollInterruptLocked:676 : Skip interrupt, 0 0
17:29:25.359: 25695: debug : virNetClientIO:1130 : All done with our call (nil) 0x15bf2f0 0
17:29:25.359: 25695: debug : virNetMessageFree:57 : msg=0x15c1d90
17:29:25.359: 25695: debug : doRemoteOpen:667 : Auto-probed URI is qemu:///system
17:29:25.359: 25695: debug : virEventPollAddTimeout:209 : Adding timer 1 with -1 ms freq
17:29:25.359: 25695: debug : virEventPollAddTimeout:217 : Used 0 timeout slots, adding at
least 10 more
17:29:25.359: 25695: debug : virEventPollInterruptLocked:676 : Skip interrupt, 0 0
17:29:25.359: 25695: debug : do_open:1059 : driver 7 remote returned SUCCESS
17:29:25.359: 25695: debug : do_open:1081 : network driver 0 Test returned DECLINED
17:29:25.359: 25695: debug : do_open:1081 : network driver 1 VBOX returned DECLINED
17:29:25.359: 25695: debug : do_open:1081 : network driver 2 ESX returned DECLINED
17:29:25.359: 25695: debug : do_open:1081 : network driver 3 remote returned SUCCESS
17:29:25.359: 25695: debug : do_open:1096 : interface driver 0 Test returned DECLINED
17:29:25.359: 25695: debug : do_open:1096 : interface driver 1 PHYP returned DECLINED
17:29:25.359: 25695: debug : do_open:1096 : interface driver 2 ESX returned DECLINED
17:29:25.359: 25695: debug : do_open:1096 : interface driver 3 remote returned SUCCESS
17:29:25.359: 25695: debug : do_open:1112 : storage driver 0 Test returned DECLINED
17:29:25.359: 25695: debug : do_open:1112 : storage driver 1 PHYP returned DECLINED
17:29:25.359: 25695: debug : do_open:1112 : storage driver 2 VBOX returned DECLINED
17:29:25.359: 25695: debug : do_open:1112 : storage driver 3 ESX returned DECLINED
17:29:25.359: 25695: debug : do_open:1112 : storage driver 4 remote returned SUCCESS
17:29:25.359: 25695: debug : do_open:1128 : node driver 0 Test returned DECLINED
17:29:25.359: 25695: debug : do_open:1128 : node driver 1 ESX returned DECLINED
17:29:25.359: 25695: debug : do_open:1128 : node driver 2 remote returned SUCCESS
17:29:25.359: 25695: debug : do_open:1144 : secret driver 0 Test returned DECLINED
17:29:25.359: 25695: debug : do_open:1144 : secret driver 1 ESX returned DECLINED
17:29:25.359: 25695: debug : do_open:1144 : secret driver 2 remote returned SUCCESS
17:29:25.359: 25695: debug : do_open:1160 : nwfilter driver 0 Test returned DECLINED
17:29:25.359: 25695: debug : do_open:1160 : nwfilter driver 1 ESX returned DECLINED
17:29:25.359: 25695: debug : do_open:1160 : nwfilter driver 2 remote returned SUCCESS
17:29:25.359: 25695: debug : virDomainLookupByName:2004 : conn=0x15bf0e0, name=f15vm2
17:29:25.359: 25695: debug : virNetMessageNew:44 : msg=0x15c1f80
17:29:25.359: 25695: debug : virNetMessageEncodePayload:255 : Encode length as 40
17:29:25.359: 25695: debug : virNetClientIO:1035 : program=536903814 version=1 serial=3
proc=23 type=0 length=40 dispatch=(nil)
17:29:25.359: 25695: debug : virNetClientIO:1103 : We have the buck 0x15bf7a0 0x15bf7a0
17:29:25.359: 25695: debug : virEventPollUpdateHandle:145 : Update handle w=2 e=0
17:29:25.359: 25695: debug : virEventPollInterruptLocked:676 : Skip interrupt, 0 0
17:29:25.360: 25695: debug : virNetMessageDecodeLength:125 : Got length, now need 60 total
(56 more)
17:29:25.360: 25695: debug : virNetClientCallDispatch:662 : Incoming message prog
536903814 vers 1 proc 23 type 1 status 0 serial 3
17:29:25.360: 25695: debug : virNetClientIOEventLoop:958 : Giving up the buck 0x15bf7a0 (nil)
17:29:25.360: 25695: debug : virEventPollUpdateHandle:145 : Update handle w=2 e=1
17:29:25.360: 25695: debug : virEventPollInterruptLocked:676 : Skip interrupt, 0 0
17:29:25.360: 25695: debug : virNetClientIO:1130 : All done with our call (nil) 0x15bf7a0 0
17:29:25.360: 25695: debug : virNetMessageFree:57 : msg=0x15c1f80
17:29:25.360: 25695: debug : virDomainGetID:3058 : dom=0x15bf3b0, (VM: name=f15vm2,
uuid=612d8af6-00e2-02eb-6825-cbe80439c149),
17:29:25.360: 25695: debug : virDomainCreate:6995 : dom=0x15bf3b0, (VM: name=f15vm2,
uuid=612d8af6-00e2-02eb-6825-cbe80439c149),
17:29:25.360: 25695: debug : virNetMessageNew:44 : msg=0x15c1f80
17:29:25.360: 25695: debug : virNetMessageEncodePayload:255 : Encode length as 60
17:29:25.360: 25695: debug : virNetClientIO:1035 : program=536903814 version=1 serial=4
proc=9 type=0 length=60 dispatch=(nil)
17:29:25.360: 25695: debug : virNetClientIO:1103 : We have the buck 0x15bf7a0 0x15bf7a0
17:29:25.360: 25695: debug : virEventPollUpdateHandle:145 : Update handle w=2 e=0
17:29:25.360: 25695: debug : virEventPollInterruptLocked:676 : Skip interrupt, 0 0
17:29:25.616: 25695: debug : virNetMessageDecodeLength:125 : Got length, now need 196
total (192 more)
17:29:25.616: 25695: debug : virNetClientCallDispatch:662 : Incoming message prog
536903814 vers 1 proc 9 type 1 status 1 serial 4
17:29:25.617: 25695: debug : virNetClientIOEventLoop:958 : Giving up the buck 0x15bf7a0 (nil)
17:29:25.617: 25695: debug : virEventPollUpdateHandle:145 : Update handle w=2 e=1
17:29:25.617: 25695: debug : virEventPollInterruptLocked:676 : Skip interrupt, 0 0
17:29:25.617: 25695: debug : virNetClientIO:1130 : All done with our call (nil) 0x15bf7a0 0
17:29:25.617: 25695: debug : virNetMessageFree:57 : msg=0x15c1f80
17:29:25.617: 25695: debug : virDomainGetName:2963 : domain=0x15bf3b0
error: Failed to start domain f15vm2
17:29:25.617: 25695: debug : virDomainFree:2144 : dom=0x15bf3b0, (VM: name=f15vm2,
uuid=612d8af6-00e2-02eb-6825-cbe80439c149),
17:29:25.617: 25695: debug : virUnrefDomain:276 : unref domain 0x15bf3b0 f15vm2 1
17:29:25.617: 25695: debug : virReleaseDomain:238 : release domain 0x15bf3b0 f15vm2
612d8af6-00e2-02eb-6825-cbe80439c149
17:29:25.617: 25695: debug : virReleaseDomain:246 : unref connection 0x15bf0e0 2
error: internal error unable to reserve PCI address 0:0:2.0
17:29:25.617: 25695: debug : virConnectClose:1320 : conn=0x15bf0e0
17:29:25.617: 25695: debug : virUnrefConnect:145 : unref connection 0x15bf0e0 1
17:29:25.617: 25695: debug : virReleaseConnect:94 : release connection 0x15bf0e0
17:29:25.617: 25695: debug : virNetMessageNew:44 : msg=0x15c1f80
17:29:25.617: 25695: debug : virNetMessageEncodePayload:255 : Encode length as 28
17:29:25.617: 25695: debug : virNetClientIO:1035 : program=536903814 version=1 serial=5
proc=2 type=0 length=28 dispatch=(nil)
17:29:25.617: 25695: debug : virNetClientIO:1103 : We have the buck 0x15bf810 0x15bf810
17:29:25.617: 25695: debug : virEventPollUpdateHandle:145 : Update handle w=2 e=0
17:29:25.617: 25695: debug : virEventPollInterruptLocked:676 : Skip interrupt, 0 0
17:29:25.618: 25695: debug : virNetMessageDecodeLength:125 : Got length, now need 28 total
(24 more)
17:29:25.618: 25695: debug : virNetClientCallDispatch:662 : Incoming message prog
536903814 vers 1 proc 2 type 1 status 0 serial 5
17:29:25.618: 25695: debug : virNetClientIOEventLoop:958 : Giving up the buck 0x15bf810 (nil)
17:29:25.618: 25695: debug : virEventPollUpdateHandle:145 : Update handle w=2 e=1
17:29:25.618: 25695: debug : virEventPollInterruptLocked:676 : Skip interrupt, 0 0
17:29:25.618: 25695: debug : virNetClientIO:1130 : All done with our call (nil) 0x15bf810 0
17:29:25.618: 25695: debug : virNetMessageFree:57 : msg=0x15c1f80
17:29:25.618: 25695: debug : virEventPollRemoveHandle:172 : Remove handle w=2
17:29:25.618: 25695: debug : virEventPollRemoveHandle:185 : mark delete 1 5
17:29:25.618: 25695: debug : virEventPollInterruptLocked:676 : Skip interrupt, 0 0
17:29:25.618: 25695: debug : virNetClientFree:244 : client=0x7ff006797010 refs=2
17:29:25.618: 25695: debug : virEventPollRemoveTimeout:277 : Remove timer 1
17:29:25.618: 25695: debug : virEventPollInterruptLocked:676 : Skip interrupt, 0 0
##############################################################################
-- /kashyap
More information about the virt
mailing list