- Users - libvirt List Archives

[libvirt-users] libvirt report error "error: End of file while reading data: Input/output error" when start domain
by Bing Bu Cao 18 Sep '13

18 Sep '13

Hi, When I want to start a VM by virsh, report error: virsh start vm1 2013-09-18 05:52:06.809+0000: 12324: info : libvirt version: 1.1.1, package: 1.mcp8_0.1 (Koji, 2013-08-09-07:55:01, lnxmcp1) 2013-09-18 05:52:06.809+0000: 12324: debug : virLogParseOutputs:1334 : outputs=1:file:/var/log/virsh.log error: Failed to start domain vm1 error: End of file while reading data: Input/output error error: One or more references were leaked after disconnect from the hypervisor error: Reconnected to the hypervisor I check the libvirtd.log and found the 'default' network is not active. If start the 'default' at first, virsh start will run sucessfully. But I was wondering why the virsh report different error against libvirtd. And why the virsh did not report "network 'default' is not active" error instead of "error: End of file while reading data: Input/output error" ? From the virsh log I found libvirt tried to read message from the socket and failed, but no idea why this happened when no 'default' network? Here is the virsh log: info : libvirt version: 1.1.1, package: 1.mcp8_0.1 (Koji, 2013-08-09-07:55:01, lnxmcp1) debug : virGlobalInit:436 : register drivers debug : virRegisterDriver:762 : driver=0x3fffd164b78 name=Test debug : virRegisterDriver:774 : registering Test as driver 0 debug : virRegisterNetworkDriver:609 : registering Test as network driver 0 debug : virRegisterInterfaceDriver:636 : registering Test as interface driver 0 debug : virRegisterStorageDriver:663 : registering Test as storage driver 0 debug : virRegisterNodeDeviceDriver:690 : registering Test as device driver 0 debug : virRegisterSecretDriver:717 : registering Test as secret driver 0 debug : virRegisterNWFilterDriver:744 : registering Test as network filter driver 0 debug : virRegisterDriver:762 : driver=0x3fffd165dd8 name=ESX debug : virRegisterDriver:774 : registering ESX as driver 1 debug : virRegisterInterfaceDriver:636 : registering ESX as interface driver 1 debug : virRegisterNetworkDriver:609 : registering ESX as network driver 1 debug : virRegisterStorageDriver:663 : registering ESX as storage driver 1 debug : virRegisterNodeDeviceDriver:690 : registering ESX as device driver 1 debug : virRegisterSecretDriver:717 : registering ESX as secret driver 1 debug : virRegisterNWFilterDriver:744 : registering ESX as network filter driver 1 debug : virRegisterDriver:762 : driver=0x3fffd165588 name=remote debug : virRegisterDriver:774 : registering remote as driver 2 debug : virRegisterNetworkDriver:609 : registering remote as network driver 2 debug : virRegisterInterfaceDriver:636 : registering remote as interface driver 2 debug : virRegisterStorageDriver:663 : registering remote as storage driver 2 debug : virRegisterNodeDeviceDriver:690 : registering remote as device driver 2 debug : virRegisterSecretDriver:717 : registering remote as secret driver 2 debug : virRegisterNWFilterDriver:744 : registering remote as network filter driver 2 debug : virEventRegisterDefaultImpl:230 : registering default event implementation debug : virEventPollAddHandle:111 : Used 0 handle slots, adding at least 10 more debug : virEventPollInterruptLocked:710 : Skip interrupt, 0 0 debug : virEventPollAddHandle:136 : EVENT_POLL_ADD_HANDLE: watch=1 fd=5 events=1 cb=0x3fffceb67a8 opaque=(nil) ff=(nil) debug : virEventRegisterImpl:203 : addHandle=0x3fffceb7060 updateHandle=0x3fffceb7450 removeHandle=0x3fffceb6814 addTimeout=0x3fffceb69c8 updateTimeout=0x3fffceb6c24 removeTimeout=0x3fffceb6e2c debug : virEventRunDefaultImpl:270 : running default event implementation debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 1 debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=5 e=1 d=0 debug : virEventPollCalculateTimeout:332 : Calculate expiry of 0 timers debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=1 timeout=-1 debug : virConnectOpenAuth:1457 : name=(null), auth=0x3fffd164728, flags=0 debug : virObjectNew:199 : OBJECT_NEW: obj=0x2aad62a1e10 classname=virConnect debug : virObjectNew:199 : OBJECT_NEW: obj=0x2aad62a1f40 classname=virConnectCloseCallbackData debug : virConnectGetConfigFile:998 : Loading config file '/etc/libvirt/libvirt.conf' debug : virConfReadFile:745 : filename=/etc/libvirt/libvirt.conf debug : virFileClose:90 : Closed fd 7 debug : do_open:1173 : no name, allowing driver auto-select debug : do_open:1215 : trying driver 0 (Test) ... debug : do_open:1222 : driver 0 Test returned DECLINED debug : do_open:1215 : trying driver 1 (ESX) ... debug : do_open:1222 : driver 1 ESX returned DECLINED debug : do_open:1215 : trying driver 2 (remote) ... debug : remoteConnectOpen:998 : Auto-probe remote URI debug : doRemoteOpen:599 : proceeding with name = debug : doRemoteOpen:608 : Connecting with transport 1 debug : doRemoteOpen:699 : Proceeding with sockname /var/run/libvirt/libvirt-sock debug : virNetSocketNew:155 : localAddr=0x3ffff825180 remoteAddr=0x3ffff825208 fd=7 errfd=-1 pid=0 debug : virObjectNew:199 : OBJECT_NEW: obj=0x2aad62a2520 classname=virNetSocket debug : virNetSocketNew:205 : RPC_SOCKET_NEW: sock=0x2aad62a2520 fd=7 errfd=-1 pid=0 localAddr=127.0.0.1;0, remoteAddr=127.0.0.1;0 debug : virObjectNew:199 : OBJECT_NEW: obj=0x2aad62a2920 classname=virNetClient debug : virNetClientNew:326 : RPC_CLIENT_NEW: client=0x2aad62a2920 sock=0x2aad62a2520 debug : virObjectRef:293 : OBJECT_REF: obj=0x2aad62a2920 debug : virObjectRef:293 : OBJECT_REF: obj=0x2aad62a2520 debug : virEventPollInterruptLocked:714 : Interrupting debug : virEventPollAddHandle:136 : EVENT_POLL_ADD_HANDLE: watch=2 fd=7 events=1 cb=0x3fffcff79e4 opaque=0x2aad62a2520 ff=0x3fffcff7948 debug : virKeepAliveNew:196 : client=0x2aad62a2920, interval=-1, count=0 debug : virObjectNew:199 : OBJECT_NEW: obj=0x2aad62a2c20 classname=virKeepAlive debug : virKeepAliveNew:215 : RPC_KEEPALIVE_NEW: ka=0x2aad62a2c20 client=0x2aad62a2920 debug : virObjectRef:293 : OBJECT_REF: obj=0x2aad62a2920 debug : virObjectRef:293 : OBJECT_REF: obj=0x2aad62a1f40 debug : virObjectNew:199 : OBJECT_NEW: obj=0x2aad62a2eb0 classname=virNetClientProgram debug : virObjectNew:199 : OBJECT_NEW: obj=0x2aad62a2850 classname=virNetClientProgram debug : virObjectNew:199 : OBJECT_NEW: obj=0x2aad62a3040 classname=virNetClientProgram debug : virObjectRef:293 : OBJECT_REF: obj=0x2aad62a2eb0 debug : virObjectRef:293 : OBJECT_REF: obj=0x2aad62a2850 debug : virObjectRef:293 : OBJECT_REF: obj=0x2aad62a3040 debug : doRemoteOpen:816 : Trying authentication debug : virNetMessageNew:44 : msg=0x2aad62a2ce0 tracked=0 debug : virNetMessageEncodePayload:373 : Encode length as 28 debug : virNetClientSendInternal:1952 : RPC_CLIENT_MSG_TX_QUEUE: client=0x2aad62a2920 len=28 prog=536903814 vers=1 proc=66 type=0 status=0 serial=0 debug : virNetClientCallNew:1905 : New call 0x2aad62a31c0: msg=0x2aad62a2ce0, expectReply=1, nonBlock=0 debug : virNetClientIO:1714 : Outgoing message prog=536903814 version=1 serial=0 proc=66 type=0 length=28 dispatch=(nil) debug : virNetClientIO:1773 : We have the buck head=0x2aad62a31c0 call=0x2aad62a31c0 debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=2 events=0 debug : virEventPollInterruptLocked:714 : Interrupting debug : virEventPollRunOnce:638 : Poll got 1 event(s) debug : virEventPollDispatchTimeouts:423 : Dispatch 0 debug : virEventPollDispatchHandles:468 : Dispatch 1 debug : virEventPollDispatchHandles:482 : i=0 w=1 debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventRunDefaultImpl:270 : running default event implementation debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=5 e=1 d=0 debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=7 e=0 d=0 debug : virEventPollCalculateTimeout:332 : Calculate expiry of 0 timers debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=1 timeout=-1 debug : virEventPollRunOnce:638 : Poll got 1 event(s) debug : virEventPollDispatchTimeouts:423 : Dispatch 0 debug : virEventPollDispatchHandles:468 : Dispatch 1 debug : virEventPollDispatchHandles:482 : i=0 w=1 debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventRunDefaultImpl:270 : running default event implementation debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=5 e=1 d=0 debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=7 e=0 d=0 debug : virEventPollCalculateTimeout:332 : Calculate expiry of 0 timers debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=1 timeout=-1 debug : virNetMessageDecodeLength:149 : Got length, now need 36 total (32 more) debug : virNetClientCallDispatch:1123 : RPC_CLIENT_MSG_RX: client=0x2aad62a2920 len=36 prog=536903814 vers=1 proc=66 type=1 status=0 serial=0 debug : virKeepAliveCheckMessage:374 : ka=0x2aad62a2c20, client=0x2aad62a2920, msg=0x2aad62a2988 debug : virNetMessageClear:55 : msg=0x2aad62a2988 nfds=0 debug : virNetClientIOEventLoopPassTheBuck:1420 : Giving up the buck 0x2aad62a31c0 debug : virNetClientIOEventLoopPassTheBuck:1434 : No thread to pass the buck to debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=2 events=1 debug : virEventPollInterruptLocked:714 : Interrupting debug : virNetClientIO:1803 : All done with our call head=(nil) call=0x2aad62a31c0 rv=0 debug : virNetMessageFree:72 : msg=0x2aad62a2ce0 nfds=0 cb=(nil) debug : virNetMessageNew:44 : msg=0x2aad62a2ce0 tracked=0 debug : virNetMessageEncodePayload:373 : Encode length as 32 debug : virNetClientSendInternal:1952 : RPC_CLIENT_MSG_TX_QUEUE: client=0x2aad62a2920 len=32 prog=536903814 vers=1 proc=60 type=0 status=0 serial=1 debug : virNetClientCallNew:1905 : New call 0x2aad62a20f0: msg=0x2aad62a2ce0, expectReply=1, nonBlock=0 debug : virNetClientIO:1714 : Outgoing message prog=536903814 version=1 serial=1 proc=60 type=0 length=32 dispatch=(nil) debug : virNetClientIO:1773 : We have the buck head=0x2aad62a20f0 call=0x2aad62a20f0 debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=2 events=0 debug : virEventPollInterruptLocked:714 : Interrupting debug : virEventPollRunOnce:638 : Poll got 1 event(s) debug : virEventPollDispatchTimeouts:423 : Dispatch 0 debug : virEventPollDispatchHandles:468 : Dispatch 1 debug : virEventPollDispatchHandles:482 : i=0 w=1 debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventRunDefaultImpl:270 : running default event implementation debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=5 e=1 d=0 debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=7 e=0 d=0 debug : virEventPollCalculateTimeout:332 : Calculate expiry of 0 timers debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=1 timeout=-1 debug : virEventPollRunOnce:638 : Poll got 1 event(s) debug : virEventPollDispatchTimeouts:423 : Dispatch 0 debug : virEventPollDispatchHandles:468 : Dispatch 1 debug : virEventPollDispatchHandles:482 : i=0 w=1 debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventRunDefaultImpl:270 : running default event implementation debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=5 e=1 d=0 debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=7 e=0 d=0 debug : virEventPollCalculateTimeout:332 : Calculate expiry of 0 timers debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=1 timeout=-1 debug : virNetMessageDecodeLength:149 : Got length, now need 32 total (28 more) debug : virNetClientCallDispatch:1123 : RPC_CLIENT_MSG_RX: client=0x2aad62a2920 len=32 prog=536903814 vers=1 proc=60 type=1 status=0 serial=1 debug : virKeepAliveCheckMessage:374 : ka=0x2aad62a2c20, client=0x2aad62a2920, msg=0x2aad62a2988 debug : virNetMessageClear:55 : msg=0x2aad62a2988 nfds=0 debug : virNetClientIOEventLoopPassTheBuck:1420 : Giving up the buck 0x2aad62a20f0 debug : virNetClientIOEventLoopPassTheBuck:1434 : No thread to pass the buck to debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=2 events=1 debug : virEventPollInterruptLocked:714 : Interrupting debug : virNetClientIO:1803 : All done with our call head=(nil) call=0x2aad62a20f0 rv=0 debug : virNetMessageFree:72 : msg=0x2aad62a2ce0 nfds=0 cb=(nil) debug : doRemoteOpen:842 : Trying to open URI debug : virNetMessageNew:44 : msg=0x2aad62a2ce0 tracked=0 debug : virNetMessageEncodePayload:373 : Encode length as 40 debug : virNetClientSendInternal:1952 : RPC_CLIENT_MSG_TX_QUEUE: client=0x2aad62a2920 len=40 prog=536903814 vers=1 proc=1 type=0 status=0 serial=2 debug : virNetClientCallNew:1905 : New call 0x2aad62a20f0: msg=0x2aad62a2ce0, expectReply=1, nonBlock=0 debug : virNetClientIO:1714 : Outgoing message prog=536903814 version=1 serial=2 proc=1 type=0 length=40 dispatch=(nil) debug : virNetClientIO:1773 : We have the buck head=0x2aad62a20f0 call=0x2aad62a20f0 debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=2 events=0 debug : virEventPollInterruptLocked:714 : Interrupting debug : virEventPollRunOnce:638 : Poll got 1 event(s) debug : virEventPollDispatchTimeouts:423 : Dispatch 0 debug : virEventPollDispatchHandles:468 : Dispatch 1 debug : virEventPollDispatchHandles:482 : i=0 w=1 debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventRunDefaultImpl:270 : running default event implementation debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=5 e=1 d=0 debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=7 e=0 d=0 debug : virEventPollCalculateTimeout:332 : Calculate expiry of 0 timers debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=1 timeout=-1 debug : virEventPollRunOnce:638 : Poll got 1 event(s) debug : virEventPollDispatchTimeouts:423 : Dispatch 0 debug : virEventPollDispatchHandles:468 : Dispatch 1 debug : virEventPollDispatchHandles:482 : i=0 w=1 debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventRunDefaultImpl:270 : running default event implementation debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=5 e=1 d=0 debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=7 e=0 d=0 debug : virEventPollCalculateTimeout:332 : Calculate expiry of 0 timers debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=1 timeout=-1 debug : virNetMessageDecodeLength:149 : Got length, now need 28 total (24 more) debug : virNetClientCallDispatch:1123 : RPC_CLIENT_MSG_RX: client=0x2aad62a2920 len=28 prog=536903814 vers=1 proc=1 type=1 status=0 serial=2 debug : virKeepAliveCheckMessage:374 : ka=0x2aad62a2c20, client=0x2aad62a2920, msg=0x2aad62a2988 debug : virNetMessageClear:55 : msg=0x2aad62a2988 nfds=0 debug : virNetClientIOEventLoopPassTheBuck:1420 : Giving up the buck 0x2aad62a20f0 debug : virNetClientIOEventLoopPassTheBuck:1434 : No thread to pass the buck to debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=2 events=1 debug : virEventPollInterruptLocked:714 : Interrupting debug : virNetClientIO:1803 : All done with our call head=(nil) call=0x2aad62a20f0 rv=0 debug : virNetMessageFree:72 : msg=0x2aad62a2ce0 nfds=0 cb=(nil) debug : doRemoteOpen:853 : Trying to query remote URI debug : virNetMessageNew:44 : msg=0x2aad62a2ce0 tracked=0 debug : virNetMessageEncodePayload:373 : Encode length as 28 debug : virNetClientSendInternal:1952 : RPC_CLIENT_MSG_TX_QUEUE: client=0x2aad62a2920 len=28 prog=536903814 vers=1 proc=110 type=0 status=0 serial=3 debug : virNetClientCallNew:1905 : New call 0x2aad62a20f0: msg=0x2aad62a2ce0, expectReply=1, nonBlock=0 debug : virNetClientIO:1714 : Outgoing message prog=536903814 version=1 serial=3 proc=110 type=0 length=28 dispatch=(nil) debug : virNetClientIO:1773 : We have the buck head=0x2aad62a20f0 call=0x2aad62a20f0 debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=2 events=0 debug : virEventPollInterruptLocked:714 : Interrupting debug : virEventPollRunOnce:638 : Poll got 1 event(s) debug : virEventPollDispatchTimeouts:423 : Dispatch 0 debug : virEventPollDispatchHandles:468 : Dispatch 1 debug : virEventPollDispatchHandles:482 : i=0 w=1 debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventRunDefaultImpl:270 : running default event implementation debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=5 e=1 d=0 debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=7 e=0 d=0 debug : virEventPollCalculateTimeout:332 : Calculate expiry of 0 timers debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=1 timeout=-1 debug : virEventPollRunOnce:638 : Poll got 1 event(s) debug : virEventPollDispatchTimeouts:423 : Dispatch 0 debug : virEventPollDispatchHandles:468 : Dispatch 1 debug : virEventPollDispatchHandles:482 : i=0 w=1 debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventRunDefaultImpl:270 : running default event implementation debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=5 e=1 d=0 debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=7 e=0 d=0 debug : virEventPollCalculateTimeout:332 : Calculate expiry of 0 timers debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=1 timeout=-1 debug : virNetMessageDecodeLength:149 : Got length, now need 48 total (44 more) debug : virNetClientCallDispatch:1123 : RPC_CLIENT_MSG_RX: client=0x2aad62a2920 len=48 prog=536903814 vers=1 proc=110 type=1 status=0 serial=3 debug : virKeepAliveCheckMessage:374 : ka=0x2aad62a2c20, client=0x2aad62a2920, msg=0x2aad62a2988 debug : virNetMessageClear:55 : msg=0x2aad62a2988 nfds=0 debug : virNetClientIOEventLoopPassTheBuck:1420 : Giving up the buck 0x2aad62a20f0 debug : virNetClientIOEventLoopPassTheBuck:1434 : No thread to pass the buck to debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=2 events=1 debug : virEventPollInterruptLocked:714 : Interrupting debug : virNetClientIO:1803 : All done with our call head=(nil) call=0x2aad62a20f0 rv=0 debug : virNetMessageFree:72 : msg=0x2aad62a2ce0 nfds=0 cb=(nil) debug : doRemoteOpen:861 : Auto-probed URI is qemu:///system debug : do_open:1222 : driver 2 remote returned SUCCESS debug : do_open:1248 : network driver 0 Test returned DECLINED debug : do_open:1248 : network driver 1 ESX returned DECLINED debug : do_open:1248 : network driver 2 remote returned SUCCESS debug : do_open:1264 : interface driver 0 Test returned DECLINED debug : do_open:1264 : interface driver 1 ESX returned DECLINED debug : do_open:1264 : interface driver 2 remote returned SUCCESS debug : do_open:1281 : storage driver 0 Test returned DECLINED debug : do_open:1281 : storage driver 1 ESX returned DECLINED debug : do_open:1281 : storage driver 2 remote returned SUCCESS debug : do_open:1298 : node driver 0 Test returned DECLINED debug : do_open:1298 : node driver 1 ESX returned DECLINED debug : do_open:1298 : node driver 2 remote returned SUCCESS debug : do_open:1315 : secret driver 0 Test returned DECLINED debug : do_open:1315 : secret driver 1 ESX returned DECLINED debug : do_open:1315 : secret driver 2 remote returned SUCCESS debug : do_open:1332 : nwfilter driver 0 Test returned DECLINED debug : do_open:1332 : nwfilter driver 1 ESX returned DECLINED debug : do_open:1332 : nwfilter driver 2 remote returned SUCCESS debug : virConnectRegisterCloseCallback:21344 : conn=0x2aad62a1e10 debug : virObjectRef:293 : OBJECT_REF: obj=0x2aad62a1e10 debug : virConnectIsAlive:21292 : conn=0x2aad62a1e10 debug : virDomainLookupByName:2242 : conn=0x2aad62a1e10, name=vm1 debug : virNetMessageNew:44 : msg=0x2aad62a2ce0 tracked=0 debug : virNetMessageEncodePayload:373 : Encode length as 36 debug : virNetClientSendInternal:1952 : RPC_CLIENT_MSG_TX_QUEUE: client=0x2aad62a2920 len=36 prog=536903814 vers=1 proc=23 type=0 status=0 serial=4 debug : virNetClientCallNew:1905 : New call 0x2aad62a2e40: msg=0x2aad62a2ce0, expectReply=1, nonBlock=0 debug : virNetClientIO:1714 : Outgoing message prog=536903814 version=1 serial=4 proc=23 type=0 length=36 dispatch=(nil) debug : virNetClientIO:1773 : We have the buck head=0x2aad62a2e40 call=0x2aad62a2e40 debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=2 events=0 debug : virEventPollInterruptLocked:714 : Interrupting debug : virEventPollRunOnce:638 : Poll got 1 event(s) debug : virEventPollDispatchTimeouts:423 : Dispatch 0 debug : virEventPollDispatchHandles:468 : Dispatch 1 debug : virEventPollDispatchHandles:482 : i=0 w=1 debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventRunDefaultImpl:270 : running default event implementation debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=5 e=1 d=0 debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=7 e=0 d=0 debug : virEventPollCalculateTimeout:332 : Calculate expiry of 0 timers debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=1 timeout=-1 debug : virEventPollRunOnce:638 : Poll got 1 event(s) debug : virEventPollDispatchTimeouts:423 : Dispatch 0 debug : virEventPollDispatchHandles:468 : Dispatch 1 debug : virEventPollDispatchHandles:482 : i=0 w=1 debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventRunDefaultImpl:270 : running default event implementation debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=5 e=1 d=0 debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=7 e=0 d=0 debug : virEventPollCalculateTimeout:332 : Calculate expiry of 0 timers debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=1 timeout=-1 debug : virNetMessageDecodeLength:149 : Got length, now need 56 total (52 more) debug : virNetClientCallDispatch:1123 : RPC_CLIENT_MSG_RX: client=0x2aad62a2920 len=56 prog=536903814 vers=1 proc=23 type=1 status=0 serial=4 debug : virKeepAliveCheckMessage:374 : ka=0x2aad62a2c20, client=0x2aad62a2920, msg=0x2aad62a2988 debug : virNetMessageClear:55 : msg=0x2aad62a2988 nfds=0 debug : virNetClientIOEventLoopPassTheBuck:1420 : Giving up the buck 0x2aad62a2e40 debug : virNetClientIOEventLoopPassTheBuck:1434 : No thread to pass the buck to debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=2 events=1 debug : virEventPollInterruptLocked:714 : Interrupting debug : virNetClientIO:1803 : All done with our call head=(nil) call=0x2aad62a2e40 rv=0 debug : virNetMessageFree:72 : msg=0x2aad62a2ce0 nfds=0 cb=(nil) debug : virObjectNew:199 : OBJECT_NEW: obj=0x2aad62a2bb0 classname=virDomain debug : virObjectRef:293 : OBJECT_REF: obj=0x2aad62a1e10 debug : virDomainGetID:3598 : dom=0x2aad62a2bb0, (VM: name=vm1, uuid=22d16da9-e05d-4e0f-bab4-bbacdfb82c92) debug : virDomainCreate:9415 : dom=0x2aad62a2bb0, (VM: name=vm1, uuid=22d16da9-e05d-4e0f-bab4-bbacdfb82c92) debug : virNetMessageNew:44 : msg=0x2aad62a2ce0 tracked=0 debug : virNetMessageEncodePayload:373 : Encode length as 56 debug : virNetClientSendInternal:1952 : RPC_CLIENT_MSG_TX_QUEUE: client=0x2aad62a2920 len=56 prog=536903814 vers=1 proc=9 type=0 status=0 serial=5 debug : virNetClientCallNew:1905 : New call 0x2aad62a2ad0: msg=0x2aad62a2ce0, expectReply=1, nonBlock=0 debug : virNetClientIO:1714 : Outgoing message prog=536903814 version=1 serial=5 proc=9 type=0 length=56 dispatch=(nil) debug : virNetClientIO:1773 : We have the buck head=0x2aad62a2ad0 call=0x2aad62a2ad0 debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=2 events=0 debug : virEventPollInterruptLocked:714 : Interrupting debug : virEventPollRunOnce:638 : Poll got 1 event(s) debug : virEventPollDispatchTimeouts:423 : Dispatch 0 debug : virEventPollDispatchHandles:468 : Dispatch 1 debug : virEventPollDispatchHandles:482 : i=0 w=1 debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventRunDefaultImpl:270 : running default event implementation debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=5 e=1 d=0 debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=7 e=0 d=0 debug : virEventPollCalculateTimeout:332 : Calculate expiry of 0 timers debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=1 timeout=-1 debug : virEventPollRunOnce:638 : Poll got 1 event(s) debug : virEventPollDispatchTimeouts:423 : Dispatch 0 debug : virEventPollDispatchHandles:468 : Dispatch 1 debug : virEventPollDispatchHandles:482 : i=0 w=1 debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventRunDefaultImpl:270 : running default event implementation debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=5 e=1 d=0 debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=7 e=0 d=0 debug : virEventPollCalculateTimeout:332 : Calculate expiry of 0 timers debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=1 timeout=-1 error : virNetSocketReadWire:1377 : End of file while reading data: Input/output error debug : virNetClientMarkClose:633 : client=0x2aad62a2920, reason=0 debug : virEventPollRemoveHandle:180 : EVENT_POLL_REMOVE_HANDLE: watch=2 debug : virEventPollRemoveHandle:193 : mark delete 1 7 debug : virEventPollInterruptLocked:714 : Interrupting debug : virNetClientIOEventLoopPassTheBuck:1420 : Giving up the buck 0x2aad62a2ad0 debug : virNetClientIOEventLoopPassTheBuck:1434 : No thread to pass the buck to debug : virNetClientCloseLocked:646 : client=0x2aad62a2920, sock=0x2aad62a2520, reason=0 debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x2aad62a2520 debug : virObjectRef:293 : OBJECT_REF: obj=0x2aad62a2920 debug : virKeepAliveStop:307 : RPC_KEEPALIVE_STOP: ka=0x2aad62a2c20 client=0x2aad62a2920 debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x2aad62a2c20 debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x2aad62a2c20 debug : virKeepAliveDispose:227 : RPC_KEEPALIVE_DISPOSE: ka=0x2aad62a2c20 debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x2aad62a2920 debug : remoteClientCloseFunc:361 : Triggering connection close callback 0x2aad61b6efc reason=0, opaque=(nil) debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x2aad62a2920 debug : virNetClientIO:1803 : All done with our call head=(nil) call=0x2aad62a2ad0 rv=-1 debug : virNetMessageFree:72 : msg=0x2aad62a2ce0 nfds=0 cb=(nil) debug : virDomainGetName:3510 : domain=0x2aad62a2bb0 debug : virDomainFree:2406 : dom=0x2aad62a2bb0, (VM: name=vm1, uuid=22d16da9-e05d-4e0f-bab4-bbacdfb82c92) debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x2aad62a2bb0 debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x2aad62a2bb0 debug : virDomainDispose:262 : release domain 0x2aad62a2bb0 vm1 22d16da9-e05d-4e0f-bab4-bbacdfb82c92 debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x2aad62a1e10 debug : virConnectUnregisterCloseCallback:21400 : conn=0x2aad62a1e10 error : virConnectUnregisterCloseCallback:21417 : Requested operation is not valid: A different callback was requested debug : virConnectClose:1501 : conn=0x2aad62a1e10 debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x2aad62a1e10 debug : virConnectOpenAuth:1457 : name=(null), auth=0x3fffd164728, flags=0 debug : virObjectNew:199 : OBJECT_NEW: obj=0x2aad62a2ef0 classname=virConnect debug : virObjectNew:199 : OBJECT_NEW: obj=0x2aad62a31d0 classname=virConnectCloseCallbackData debug : virConnectGetConfigFile:998 : Loading config file '/etc/libvirt/libvirt.conf' debug : virConfReadFile:745 : filename=/etc/libvirt/libvirt.conf debug : virFileClose:90 : Closed fd 10 debug : do_open:1173 : no name, allowing driver auto-select debug : do_open:1215 : trying driver 0 (Test) ... debug : do_open:1222 : driver 0 Test returned DECLINED debug : do_open:1215 : trying driver 1 (ESX) ... debug : do_open:1222 : driver 1 ESX returned DECLINED debug : do_open:1215 : trying driver 2 (remote) ... debug : remoteConnectOpen:998 : Auto-probe remote URI debug : doRemoteOpen:599 : proceeding with name = debug : doRemoteOpen:608 : Connecting with transport 1 debug : doRemoteOpen:699 : Proceeding with sockname /var/run/libvirt/libvirt-sock debug : virNetSocketNew:155 : localAddr=0x3ffff825180 remoteAddr=0x3ffff825208 fd=10 errfd=-1 pid=0 debug : virObjectNew:199 : OBJECT_NEW: obj=0x2aad62a35c0 classname=virNetSocket debug : virNetSocketNew:205 : RPC_SOCKET_NEW: sock=0x2aad62a35c0 fd=10 errfd=-1 pid=0 localAddr=127.0.0.1;0, remoteAddr=127.0.0.1;0 debug : virObjectNew:199 : OBJECT_NEW: obj=0x2aad62a3900 classname=virNetClient debug : virNetClientNew:326 : RPC_CLIENT_NEW: client=0x2aad62a3900 sock=0x2aad62a35c0 debug : virObjectRef:293 : OBJECT_REF: obj=0x2aad62a3900 debug : virObjectRef:293 : OBJECT_REF: obj=0x2aad62a35c0 debug : virEventPollInterruptLocked:714 : Interrupting debug : virEventPollAddHandle:136 : EVENT_POLL_ADD_HANDLE: watch=3 fd=10 events=1 cb=0x3fffcff79e4 opaque=0x2aad62a35c0 ff=0x3fffcff7948 debug : virKeepAliveNew:196 : client=0x2aad62a3900, interval=-1, count=0 debug : virObjectNew:199 : OBJECT_NEW: obj=0x2aad62a3ab0 classname=virKeepAlive debug : virKeepAliveNew:215 : RPC_KEEPALIVE_NEW: ka=0x2aad62a3ab0 client=0x2aad62a3900 debug : virObjectRef:293 : OBJECT_REF: obj=0x2aad62a3900 debug : virObjectRef:293 : OBJECT_REF: obj=0x2aad62a31d0 debug : virObjectNew:199 : OBJECT_NEW: obj=0x2aad62a37f0 classname=virNetClientProgram debug : virObjectNew:199 : OBJECT_NEW: obj=0x2aad62a2050 classname=virNetClientProgram debug : virObjectNew:199 : OBJECT_NEW: obj=0x2aad62a3bb0 classname=virNetClientProgram debug : virObjectRef:293 : OBJECT_REF: obj=0x2aad62a37f0 debug : virObjectRef:293 : OBJECT_REF: obj=0x2aad62a2050 debug : virObjectRef:293 : OBJECT_REF: obj=0x2aad62a3bb0 debug : doRemoteOpen:816 : Trying authentication debug : virNetMessageNew:44 : msg=0x2aad62a3db0 tracked=0 debug : virNetMessageEncodePayload:373 : Encode length as 28 debug : virNetClientSendInternal:1952 : RPC_CLIENT_MSG_TX_QUEUE: client=0x2aad62a3900 len=28 prog=536903814 vers=1 proc=66 type=0 status=0 serial=0 debug : virNetClientCallNew:1905 : New call 0x2aad62b3ec0: msg=0x2aad62a3db0, expectReply=1, nonBlock=0 debug : virNetClientIO:1714 : Outgoing message prog=536903814 version=1 serial=0 proc=66 type=0 length=28 dispatch=(nil) debug : virNetClientIO:1773 : We have the buck head=0x2aad62b3ec0 call=0x2aad62b3ec0 debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=3 events=0 debug : virEventPollInterruptLocked:714 : Interrupting debug : virEventPollRunOnce:638 : Poll got 1 event(s) debug : virEventPollDispatchTimeouts:423 : Dispatch 0 debug : virEventPollDispatchHandles:468 : Dispatch 1 debug : virEventPollDispatchHandles:482 : i=0 w=1 debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 3 debug : virEventPollCleanupHandles:575 : EVENT_POLL_PURGE_HANDLE: watch=2 debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x2aad62a2920 debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x2aad62a2520 debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x2aad62a2520 debug : virNetSocketDispose:1002 : RPC_SOCKET_DISPOSE: sock=0x2aad62a2520 debug : virEventPollRemoveHandle:180 : EVENT_POLL_REMOVE_HANDLE: watch=2 debug : virFileClose:90 : Closed fd 7 debug : virEventRunDefaultImpl:270 : running default event implementation debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=5 e=1 d=0 debug : virEventPollMakePollFDs:391 : Prepare n=1 w=3, f=10 e=0 d=0 debug : virEventPollCalculateTimeout:332 : Calculate expiry of 0 timers debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=1 timeout=-1 debug : virEventPollRunOnce:638 : Poll got 1 event(s) debug : virEventPollDispatchTimeouts:423 : Dispatch 0 debug : virEventPollDispatchHandles:468 : Dispatch 1 debug : virEventPollDispatchHandles:482 : i=0 w=1 debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventRunDefaultImpl:270 : running default event implementation debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=5 e=1 d=0 debug : virEventPollMakePollFDs:391 : Prepare n=1 w=3, f=10 e=0 d=0 debug : virEventPollCalculateTimeout:332 : Calculate expiry of 0 timers debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=1 timeout=-1 debug : virEventPollRunOnce:638 : Poll got 1 event(s) debug : virEventPollDispatchTimeouts:423 : Dispatch 0 debug : virEventPollDispatchHandles:468 : Dispatch 1 debug : virEventPollDispatchHandles:482 : i=0 w=1 debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventRunDefaultImpl:270 : running default event implementation debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=5 e=1 d=0 debug : virEventPollMakePollFDs:391 : Prepare n=1 w=3, f=10 e=0 d=0 debug : virEventPollCalculateTimeout:332 : Calculate expiry of 0 timers debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=1 timeout=-1 debug : virNetMessageDecodeLength:149 : Got length, now need 36 total (32 more) debug : virNetClientCallDispatch:1123 : RPC_CLIENT_MSG_RX: client=0x2aad62a3900 len=36 prog=536903814 vers=1 proc=66 type=1 status=0 serial=0 debug : virKeepAliveCheckMessage:374 : ka=0x2aad62a3ab0, client=0x2aad62a3900, msg=0x2aad62a3968 debug : virNetMessageClear:55 : msg=0x2aad62a3968 nfds=0 debug : virNetClientIOEventLoopPassTheBuck:1420 : Giving up the buck 0x2aad62b3ec0 debug : virNetClientIOEventLoopPassTheBuck:1434 : No thread to pass the buck to debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=3 events=1 debug : virEventPollInterruptLocked:714 : Interrupting debug : virNetClientIO:1803 : All done with our call head=(nil) call=0x2aad62b3ec0 rv=0 debug : virNetMessageFree:72 : msg=0x2aad62a3db0 nfds=0 cb=(nil) debug : virNetMessageNew:44 : msg=0x2aad62a3db0 tracked=0 debug : virNetMessageEncodePayload:373 : Encode length as 32 debug : virNetClientSendInternal:1952 : RPC_CLIENT_MSG_TX_QUEUE: client=0x2aad62a3900 len=32 prog=536903814 vers=1 proc=60 type=0 status=0 serial=1 debug : virNetClientCallNew:1905 : New call 0x2aad62a2660: msg=0x2aad62a3db0, expectReply=1, nonBlock=0 debug : virNetClientIO:1714 : Outgoing message prog=536903814 version=1 serial=1 proc=60 type=0 length=32 dispatch=(nil) debug : virNetClientIO:1773 : We have the buck head=0x2aad62a2660 call=0x2aad62a2660 debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=3 events=0 debug : virEventPollInterruptLocked:714 : Interrupting debug : virEventPollRunOnce:638 : Poll got 1 event(s) debug : virEventPollDispatchTimeouts:423 : Dispatch 0 debug : virEventPollDispatchHandles:468 : Dispatch 1 debug : virEventPollDispatchHandles:482 : i=0 w=1 debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventRunDefaultImpl:270 : running default event implementation debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=5 e=1 d=0 debug : virEventPollMakePollFDs:391 : Prepare n=1 w=3, f=10 e=0 d=0 debug : virEventPollCalculateTimeout:332 : Calculate expiry of 0 timers debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=1 timeout=-1 debug : virEventPollRunOnce:638 : Poll got 1 event(s) debug : virEventPollDispatchTimeouts:423 : Dispatch 0 debug : virEventPollDispatchHandles:468 : Dispatch 1 debug : virEventPollDispatchHandles:482 : i=0 w=1 debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventRunDefaultImpl:270 : running default event implementation debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=5 e=1 d=0 debug : virEventPollMakePollFDs:391 : Prepare n=1 w=3, f=10 e=0 d=0 debug : virEventPollCalculateTimeout:332 : Calculate expiry of 0 timers debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=1 timeout=-1 debug : virNetMessageDecodeLength:149 : Got length, now need 32 total (28 more) debug : virNetClientCallDispatch:1123 : RPC_CLIENT_MSG_RX: client=0x2aad62a3900 len=32 prog=536903814 vers=1 proc=60 type=1 status=0 serial=1 debug : virKeepAliveCheckMessage:374 : ka=0x2aad62a3ab0, client=0x2aad62a3900, msg=0x2aad62a3968 debug : virNetMessageClear:55 : msg=0x2aad62a3968 nfds=0 debug : virNetClientIOEventLoopPassTheBuck:1420 : Giving up the buck 0x2aad62a2660 debug : virNetClientIOEventLoopPassTheBuck:1434 : No thread to pass the buck to debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=3 events=1 debug : virEventPollInterruptLocked:714 : Interrupting debug : virNetClientIO:1803 : All done with our call head=(nil) call=0x2aad62a2660 rv=0 debug : virNetMessageFree:72 : msg=0x2aad62a3db0 nfds=0 cb=(nil) debug : doRemoteOpen:842 : Trying to open URI debug : virNetMessageNew:44 : msg=0x2aad62a3db0 tracked=0 debug : virNetMessageEncodePayload:373 : Encode length as 40 debug : virNetClientSendInternal:1952 : RPC_CLIENT_MSG_TX_QUEUE: client=0x2aad62a3900 len=40 prog=536903814 vers=1 proc=1 type=0 status=0 serial=2 debug : virNetClientCallNew:1905 : New call 0x2aad62a25a0: msg=0x2aad62a3db0, expectReply=1, nonBlock=0 debug : virNetClientIO:1714 : Outgoing message prog=536903814 version=1 serial=2 proc=1 type=0 length=40 dispatch=(nil) debug : virNetClientIO:1773 : We have the buck head=0x2aad62a25a0 call=0x2aad62a25a0 debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=3 events=0 debug : virEventPollInterruptLocked:714 : Interrupting debug : virEventPollRunOnce:638 : Poll got 1 event(s) debug : virEventPollDispatchTimeouts:423 : Dispatch 0 debug : virEventPollDispatchHandles:468 : Dispatch 1 debug : virEventPollDispatchHandles:482 : i=0 w=1 debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventRunDefaultImpl:270 : running default event implementation debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=5 e=1 d=0 debug : virEventPollMakePollFDs:391 : Prepare n=1 w=3, f=10 e=0 d=0 debug : virEventPollCalculateTimeout:332 : Calculate expiry of 0 timers debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=1 timeout=-1 debug : virEventPollRunOnce:638 : Poll got 1 event(s) debug : virEventPollDispatchTimeouts:423 : Dispatch 0 debug : virEventPollDispatchHandles:468 : Dispatch 1 debug : virEventPollDispatchHandles:482 : i=0 w=1 debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventRunDefaultImpl:270 : running default event implementation debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=5 e=1 d=0 debug : virEventPollMakePollFDs:391 : Prepare n=1 w=3, f=10 e=0 d=0 debug : virEventPollCalculateTimeout:332 : Calculate expiry of 0 timers debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=1 timeout=-1 debug : virNetMessageDecodeLength:149 : Got length, now need 28 total (24 more) debug : virNetClientCallDispatch:1123 : RPC_CLIENT_MSG_RX: client=0x2aad62a3900 len=28 prog=536903814 vers=1 proc=1 type=1 status=0 serial=2 debug : virKeepAliveCheckMessage:374 : ka=0x2aad62a3ab0, client=0x2aad62a3900, msg=0x2aad62a3968 debug : virNetMessageClear:55 : msg=0x2aad62a3968 nfds=0 debug : virNetClientIOEventLoopPassTheBuck:1420 : Giving up the buck 0x2aad62a25a0 debug : virNetClientIOEventLoopPassTheBuck:1434 : No thread to pass the buck to debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=3 events=1 debug : virEventPollInterruptLocked:714 : Interrupting debug : virNetClientIO:1803 : All done with our call head=(nil) call=0x2aad62a25a0 rv=0 debug : virNetMessageFree:72 : msg=0x2aad62a3db0 nfds=0 cb=(nil) debug : doRemoteOpen:853 : Trying to query remote URI debug : virNetMessageNew:44 : msg=0x2aad62a3db0 tracked=0 debug : virNetMessageEncodePayload:373 : Encode length as 28 debug : virNetClientSendInternal:1952 : RPC_CLIENT_MSG_TX_QUEUE: client=0x2aad62a3900 len=28 prog=536903814 vers=1 proc=110 type=0 status=0 serial=3 debug : virNetClientCallNew:1905 : New call 0x2aad62a2670: msg=0x2aad62a3db0, expectReply=1, nonBlock=0 debug : virNetClientIO:1714 : Outgoing message prog=536903814 version=1 serial=3 proc=110 type=0 length=28 dispatch=(nil) debug : virNetClientIO:1773 : We have the buck head=0x2aad62a2670 call=0x2aad62a2670 debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=3 events=0 debug : virEventPollInterruptLocked:714 : Interrupting debug : virEventPollRunOnce:638 : Poll got 1 event(s) debug : virEventPollDispatchTimeouts:423 : Dispatch 0 debug : virEventPollDispatchHandles:468 : Dispatch 1 debug : virEventPollDispatchHandles:482 : i=0 w=1 debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventRunDefaultImpl:270 : running default event implementation debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=5 e=1 d=0 debug : virEventPollMakePollFDs:391 : Prepare n=1 w=3, f=10 e=0 d=0 debug : virEventPollCalculateTimeout:332 : Calculate expiry of 0 timers debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=1 timeout=-1 debug : virEventPollRunOnce:638 : Poll got 1 event(s) debug : virEventPollDispatchTimeouts:423 : Dispatch 0 debug : virEventPollDispatchHandles:468 : Dispatch 1 debug : virEventPollDispatchHandles:482 : i=0 w=1 debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventRunDefaultImpl:270 : running default event implementation debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=5 e=1 d=0 debug : virEventPollMakePollFDs:391 : Prepare n=1 w=3, f=10 e=0 d=0 debug : virEventPollCalculateTimeout:332 : Calculate expiry of 0 timers debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=1 timeout=-1 debug : virNetMessageDecodeLength:149 : Got length, now need 48 total (44 more) debug : virNetClientCallDispatch:1123 : RPC_CLIENT_MSG_RX: client=0x2aad62a3900 len=48 prog=536903814 vers=1 proc=110 type=1 status=0 serial=3 debug : virKeepAliveCheckMessage:374 : ka=0x2aad62a3ab0, client=0x2aad62a3900, msg=0x2aad62a3968 debug : virNetMessageClear:55 : msg=0x2aad62a3968 nfds=0 debug : virNetClientIOEventLoopPassTheBuck:1420 : Giving up the buck 0x2aad62a2670 debug : virNetClientIOEventLoopPassTheBuck:1434 : No thread to pass the buck to debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=3 events=1 debug : virEventPollInterruptLocked:714 : Interrupting debug : virNetClientIO:1803 : All done with our call head=(nil) call=0x2aad62a2670 rv=0 debug : virNetMessageFree:72 : msg=0x2aad62a3db0 nfds=0 cb=(nil) debug : doRemoteOpen:861 : Auto-probed URI is qemu:///system debug : do_open:1222 : driver 2 remote returned SUCCESS debug : do_open:1248 : network driver 0 Test returned DECLINED debug : do_open:1248 : network driver 1 ESX returned DECLINED debug : do_open:1248 : network driver 2 remote returned SUCCESS debug : do_open:1264 : interface driver 0 Test returned DECLINED debug : do_open:1264 : interface driver 1 ESX returned DECLINED debug : do_open:1264 : interface driver 2 remote returned SUCCESS debug : do_open:1281 : storage driver 0 Test returned DECLINED debug : do_open:1281 : storage driver 1 ESX returned DECLINED debug : do_open:1281 : storage driver 2 remote returned SUCCESS debug : do_open:1298 : node driver 0 Test returned DECLINED debug : do_open:1298 : node driver 1 ESX returned DECLINED debug : do_open:1298 : node driver 2 remote returned SUCCESS debug : do_open:1315 : secret driver 0 Test returned DECLINED debug : do_open:1315 : secret driver 1 ESX returned DECLINED debug : do_open:1315 : secret driver 2 remote returned SUCCESS debug : do_open:1332 : nwfilter driver 0 Test returned DECLINED debug : do_open:1332 : nwfilter driver 1 ESX returned DECLINED debug : do_open:1332 : nwfilter driver 2 remote returned SUCCESS debug : virConnectRegisterCloseCallback:21344 : conn=0x2aad62a2ef0 debug : virObjectRef:293 : OBJECT_REF: obj=0x2aad62a2ef0 debug : virEventPollRunOnce:638 : Poll got 1 event(s) debug : virEventPollDispatchTimeouts:423 : Dispatch 0 debug : virEventPollDispatchHandles:468 : Dispatch 1 debug : virEventPollDispatchHandles:482 : i=0 w=1 debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventRunDefaultImpl:270 : running default event implementation debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=5 e=1 d=0 debug : virEventPollMakePollFDs:391 : Prepare n=1 w=3, f=10 e=1 d=0 debug : virEventPollCalculateTimeout:332 : Calculate expiry of 0 timers debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=2 timeout=-1 debug : virConnectUnregisterCloseCallback:21400 : conn=0x2aad62a2ef0 debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x2aad62a2ef0 debug : virConnectClose:1501 : conn=0x2aad62a2ef0 debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x2aad62a2ef0 debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x2aad62a2ef0 debug : virNetMessageNew:44 : msg=0x2aad62a2ac0 tracked=0 debug : virNetMessageEncodePayload:373 : Encode length as 28 debug : virNetClientSendInternal:1952 : RPC_CLIENT_MSG_TX_QUEUE: client=0x2aad62a3900 len=28 prog=536903814 vers=1 proc=2 type=0 status=0 serial=4 debug : virNetClientCallNew:1905 : New call 0x2aad62a3240: msg=0x2aad62a2ac0, expectReply=1, nonBlock=0 debug : virNetClientIO:1714 : Outgoing message prog=536903814 version=1 serial=4 proc=2 type=0 length=28 dispatch=(nil) debug : virNetClientIO:1773 : We have the buck head=0x2aad62a3240 call=0x2aad62a3240 debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=3 events=0 debug : virEventPollInterruptLocked:714 : Interrupting debug : virEventPollRunOnce:638 : Poll got 1 event(s) debug : virEventPollDispatchTimeouts:423 : Dispatch 0 debug : virEventPollDispatchHandles:468 : Dispatch 2 debug : virEventPollDispatchHandles:482 : i=0 w=1 debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventRunDefaultImpl:270 : running default event implementation debug : virEventPollCleanupTimeouts:514 : Cleanup 0 debug : virEventPollCleanupTimeouts:550 : Found 0 out of 0 timeout slots used, releasing 0 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=5 e=1 d=0 debug : virEventPollMakePollFDs:391 : Prepare n=1 w=3, f=10 e=0 d=0 debug : virEventPollCalculateTimeout:332 : Calculate expiry of 0 timers debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=1 timeout=-1 debug : virNetMessageDecodeLength:149 : Got length, now need 28 total (24 more) debug : virNetClientCallDispatch:1123 : RPC_CLIENT_MSG_RX: client=0x2aad62a3900 len=28 prog=536903814 vers=1 proc=2 type=1 status=0 serial=4 debug : virKeepAliveCheckMessage:374 : ka=0x2aad62a3ab0, client=0x2aad62a3900, msg=0x2aad62a3968 debug : virNetMessageClear:55 : msg=0x2aad62a3968 nfds=0 debug : virNetClientIOEventLoopPassTheBuck:1420 : Giving up the buck 0x2aad62a3240 debug : virNetClientIOEventLoopPassTheBuck:1434 : No thread to pass the buck to debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=3 events=1 debug : virEventPollInterruptLocked:714 : Interrupting debug : virNetClientIO:1803 : All done with our call head=(nil) call=0x2aad62a3240 rv=0 debug : virNetMessageFree:72 : msg=0x2aad62a2ac0 nfds=0 cb=(nil) debug : virNetClientCloseInternal:687 : client=0x2aad62a3900 wantclose=0 debug : virNetClientMarkClose:633 : client=0x2aad62a3900, reason=3 debug : virEventPollRemoveHandle:180 : EVENT_POLL_REMOVE_HANDLE: watch=3 debug : virEventPollRemoveHandle:193 : mark delete 1 10 debug : virEventPollInterruptLocked:714 : Interrupting debug : virNetClientIOEventLoopPassTheBuck:1420 : Giving up the buck (nil) debug : virNetClientIOEventLoopPassTheBuck:1434 : No thread to pass the buck to debug : virNetClientCloseLocked:646 : client=0x2aad62a3900, sock=0x2aad62a35c0, reason=3 debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x2aad62a35c0 debug : virObjectRef:293 : OBJECT_REF: obj=0x2aad62a3900 debug : virKeepAliveStop:307 : RPC_KEEPALIVE_STOP: ka=0x2aad62a3ab0 client=0x2aad62a3900 debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x2aad62a3ab0 debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x2aad62a3ab0 debug : virKeepAliveDispose:227 : RPC_KEEPALIVE_DISPOSE: ka=0x2aad62a3ab0 debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x2aad62a3900 debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x2aad62a3900 debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x2aad62a3900 debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x2aad62a37f0 debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x2aad62a2050 debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x2aad62a3bb0 debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x2aad62a31d0 debug : virEventPollAddTimeout:225 : Used 0 timeout slots, adding at least 10 more debug : virEventPollInterruptLocked:714 : Interrupting debug : virEventPollAddTimeout:248 : EVENT_POLL_ADD_TIMEOUT: timer=1 frequency=0 cb=0x2aad61b6f9c opaque=(nil) ff=(nil) debug : virEventPollRunOnce:638 : Poll got 1 event(s) debug : virEventPollDispatchTimeouts:423 : Dispatch 1 debug : virEventPollDispatchTimeouts:446 : EVENT_POLL_DISPATCH_TIMEOUT: timer=1 debug : virEventPollDispatchHandles:468 : Dispatch 1 debug : virEventPollDispatchHandles:482 : i=0 w=1 debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 debug : virEventPollCleanupTimeouts:514 : Cleanup 1 debug : virEventPollCleanupHandles:562 : Cleanup 2 debug : virEventPollCleanupHandles:575 : EVENT_POLL_PURGE_HANDLE: watch=3 debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x2aad62a3900 debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x2aad62a3900 debug : virNetClientDispose:599 : RPC_CLIENT_DISPOSE: client=0x2aad62a3900 debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x2aad62a31d0 debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x2aad62a31d0 debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x2aad62a37f0 debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x2aad62a37f0 debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x2aad62a2050 debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x2aad62a2050 debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x2aad62a3bb0 debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x2aad62a3bb0 debug : virFileClose:90 : Closed fd 12 debug : virFileClose:90 : Closed fd 11 debug : virNetMessageClear:55 : msg=0x2aad62a3968 nfds=0 debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x2aad62a35c0 debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x2aad62a35c0 debug : virNetSocketDispose:1002 : RPC_SOCKET_DISPOSE: sock=0x2aad62a35c0 debug : virEventPollRemoveHandle:180 : EVENT_POLL_REMOVE_HANDLE: watch=3 debug : virFileClose:90 : Closed fd 10 debug : virEventPollRemoveTimeout:300 : EVENT_POLL_REMOVE_TIMEOUT: timer=1 debug : virEventPollInterruptLocked:710 : Skip interrupt, 0 4397868808464 -- Best Regards, Mars-+

1 0

Re: [libvirt-users] libvirt-users Digest, Vol 45, Issue 28
by Matthias Babisch 17 Sep '13

17 Sep '13

Test libvirt-users-request(a)redhat.com schrieb: >Send libvirt-users mailing list submissions to > libvirt-users(a)redhat.com > >To subscribe or unsubscribe via the World Wide Web, visit > https://www.redhat.com/mailman/listinfo/libvirt-users >or, via email, send a message with subject or body 'help' to > libvirt-users-request(a)redhat.com > >You can reach the person managing the list at > libvirt-users-owner(a)redhat.com > >When replying, please edit your Subject line so it is more specific >than "Re: Contents of libvirt-users digest..." > > >Today's Topics: > > 1. Finding out CPU topology. (Peeyush Gupta) > 2. Re: Finding out CPU topology. (Daniel P. Berrange) > 3. Re: Finding out CPU topology. (Peeyush Gupta) > > >---------------------------------------------------------------------- > >Message: 1 >Date: Tue, 17 Sep 2013 17:41:12 +0800 (SGT) >From: Peeyush Gupta <gpeeyush(a)ymail.com> >To: "libvirt-users(a)redhat.com" <libvirt-users(a)redhat.com> >Subject: [libvirt-users] Finding out CPU topology. >Message-ID: > <1379410872.26498.YahooMailNeo(a)web194604.mail.sg3.yahoo.com> >Content-Type: text/plain; charset="iso-8859-1" > >Hi all, > >I have been trying to find out cpu topology using libvirt. When >I do 'virsh capabilites', I find this inside <topology> tag: > > ><topology> >? ? ? <cells num='1'> >? ? ? ? <cell id='0'> >? ? ? ? ? <memory unit='KiB'>3908488</memory> >? ? ? ? ? <cpus num='4'> >? ? ? ? ? ? <cpu id='0' socket_id='0' core_id='0' siblings='0'/> >? ? ? ? ? ? <cpu id='1' socket_id='0' core_id='0' siblings='1'/> >? ? ? ? ? ? <cpu id='2' socket_id='0' core_id='1' siblings='2'/> >? ? ? ? ? ? <cpu id='3' socket_id='0' core_id='1' siblings='3'/> >? ? ? ? ? </cpus> >? ? ? ? </cell> >? ? ? </cells> ></topology> > >But when I use the 'getCapbilities()' function of the python binding, >the result is: ><topology> ? ? >? <cells num='1'> ?? >? ? ?<cell id='0'> ? ? ? ?? >? ? ?<cpus num='4'> ?? >? ? ? ?<cpu id='0'/> >? ? ? ?<cpu id='1'/> >? ? ? ?<cpu id='2'/> >? ? ? ?<cpu id='3'/> ? ? ? ?? >? ? ?</cpus> ? ? ? ? >? ?</cell> ? ? ? >?</cells> ? ></topology>\n > >As you can see this doesnt give any information about >socket/core/thread etc. >What I an interested to know is that is it a limitation of python >binding or libvirt >C API itself? How can I get the whole topology without just parsing the >output >of virsh capabilities? > >Thanks. >~Peeyush Gupta >-------------- next part -------------- >An HTML attachment was scrubbed... >URL: ><https://www.redhat.com/archives/libvirt-users/attachments/20130917/ff834444…> > >------------------------------ > >Message: 2 >Date: Tue, 17 Sep 2013 10:49:29 +0100 >From: "Daniel P. Berrange" <berrange(a)redhat.com> >To: Peeyush Gupta <gpeeyush(a)ymail.com> >Cc: "libvirt-users(a)redhat.com" <libvirt-users(a)redhat.com> >Subject: Re: [libvirt-users] Finding out CPU topology. >Message-ID: <20130917094929.GD28204(a)redhat.com> >Content-Type: text/plain; charset=utf-8 > >On Tue, Sep 17, 2013 at 05:41:12PM +0800, Peeyush Gupta wrote: >> Hi all, >> >> I have been trying to find out cpu topology using libvirt. When >> I do 'virsh capabilites', I find this inside <topology> tag: >> >> >> <topology> >> ? ? ? <cells num='1'> >> ? ? ? ? <cell id='0'> >> ? ? ? ? ? <memory unit='KiB'>3908488</memory> >> ? ? ? ? ? <cpus num='4'> >> ? ? ? ? ? ? <cpu id='0' socket_id='0' core_id='0' siblings='0'/> >> ? ? ? ? ? ? <cpu id='1' socket_id='0' core_id='0' siblings='1'/> >> ? ? ? ? ? ? <cpu id='2' socket_id='0' core_id='1' siblings='2'/> >> ? ? ? ? ? ? <cpu id='3' socket_id='0' core_id='1' siblings='3'/> >> ? ? ? ? ? </cpus> >> ? ? ? ? </cell> >> ? ? ? </cells> >> </topology> >> >> But when I use the 'getCapbilities()' function of the python binding, >> the result is: >> <topology> ? ? >> ? <cells num='1'> ?? >> ? ? ?<cell id='0'> ? ? ? ?? >> ? ? ?<cpus num='4'> ?? >> ? ? ? ?<cpu id='0'/> >> ? ? ? ?<cpu id='1'/> >> ? ? ? ?<cpu id='2'/> >> ? ? ? ?<cpu id='3'/> ? ? ? ?? >> ? ? ?</cpus> ? ? ? ? >> ? ?</cell> ? ? ? >> ?</cells> ? >> </topology>\n >> >> As you can see this doesnt give any information about >socket/core/thread etc. >> What I an interested to know is that is it a limitation of python >binding or libvirt >> C API itself? How can I get the whole topology without just parsing >the output >> of virsh capabilities? > >Did you really run these two examples on the same machine, with the >same >libvirt URI ? Both virsh and the python binding call the same libvirt >API >'virConnectGetCapabilities' so will return the same data if run against >the same libvirt. The socket_id, core_id and siblings data is a >relatively >new feature we added, so older libvirt won't show it. > >Daniel >-- >|: http://berrange.com -o- >http://www.flickr.com/photos/dberrange/ :| >|: http://libvirt.org -o- >http://virt-manager.org :| >|: http://autobuild.org -o- >http://search.cpan.org/~danberr/ :| >|: http://entangle-photo.org -o- >http://live.gnome.org/gtk-vnc :| > > > >------------------------------ > >Message: 3 >Date: Tue, 17 Sep 2013 17:54:40 +0800 (SGT) >From: Peeyush Gupta <gpeeyush(a)ymail.com> >To: "Daniel P. Berrange" <berrange(a)redhat.com> >Cc: "libvirt-users(a)redhat.com" <libvirt-users(a)redhat.com> >Subject: Re: [libvirt-users] Finding out CPU topology. >Message-ID: > <1379411680.85399.YahooMailNeo(a)web194601.mail.sg3.yahoo.com> >Content-Type: text/plain; charset="iso-8859-1" > >Yes, I have run both of them on same machine. And?I? >am running libvirt 1.1.0. So, I guess it's not ?a?problem? >of older version. >? >Thanks >~Peeyush Gupta > > >________________________________ > From: Daniel P. Berrange <berrange(a)redhat.com> >To: Peeyush Gupta <gpeeyush(a)ymail.com> >Cc: "libvirt-users(a)redhat.com" <libvirt-users(a)redhat.com> >Sent: Tuesday, 17 September 2013 3:19 PM >Subject: Re: [libvirt-users] Finding out CPU topology. > > >On Tue, Sep 17, 2013 at 05:41:12PM +0800, Peeyush Gupta wrote: >> Hi all, >> >> I have been trying to find out cpu topology using libvirt. When >> I do 'virsh capabilites', I find this inside <topology> tag: >> >> >> <topology> >> ? ? ? <cells num='1'> >> ? ? ? ? <cell id='0'> >> ? ? ? ? ? <memory unit='KiB'>3908488</memory> >> ? ? ? ? ? <cpus num='4'> >> ? ? ? ? ? ? <cpu id='0' socket_id='0' core_id='0' siblings='0'/> >> ? ? ? ? ? ? <cpu id='1' socket_id='0' core_id='0' siblings='1'/> >> ? ? ? ? ? ? <cpu id='2' socket_id='0' core_id='1' siblings='2'/> >> ? ? ? ? ? ? <cpu id='3' socket_id='0' core_id='1' siblings='3'/> >> ? ? ? ? ? </cpus> >> ? ? ? ? </cell> >> ? ? ? </cells> >> </topology> >> >> But when I use the 'getCapbilities()' function of the python binding, >> the result is: >> <topology> ? ? >> ? <cells num='1'> ?? >> ? ? ?<cell id='0'> ? ? ? ?? >> ? ? ?<cpus num='4'> ?? >> ? ? ? ?<cpu id='0'/> >> ? ? ? ?<cpu id='1'/> >> ? ? ? ?<cpu id='2'/> >> ? ? ? ?<cpu id='3'/> ? ? ? ?? >> ? ? ?</cpus> ? ? ? ? >> ? ?</cell> ? ? ? >> ?</cells> ? >> </topology>\n >> >> As you can see this doesnt give any information about >socket/core/thread etc. >> What I an interested to know is that is it a limitation of python >binding or libvirt >> C API itself? How can I get the whole topology without just parsing >the output >> of virsh capabilities? > >Did you really run these two examples on the same machine, with the >same >libvirt URI ? Both virsh and the python binding call the same libvirt >API >'virConnectGetCapabilities' so will return the same data if run against >the same libvirt. The socket_id, core_id and siblings data is a >relatively >new feature we added, so older libvirt won't show it. > >Daniel >-- >|: http://berrange.com? ? ? -o-? ? >http://www.flickr.com/photos/dberrange/ :| >|: http://libvirt.org? ? ? ? ? ? ? -o-? ? ? ? ? ? >http://virt-manager.org :| >|: http://autobuild.org? ? ? -o-? ? ? ? >http://search.cpan.org/~danberr/ :| >|: http://entangle-photo.org? ? ? -o-? ? ? >http://live.gnome.org/gtk-vnc :| >-------------- next part -------------- >An HTML attachment was scrubbed... >URL: ><https://www.redhat.com/archives/libvirt-users/attachments/20130917/df8c7fbf…> > >------------------------------ > >_______________________________________________ >libvirt-users mailing list >libvirt-users(a)redhat.com >https://www.redhat.com/mailman/listinfo/libvirt-users > >End of libvirt-users Digest, Vol 45, Issue 28 >********************************************* -- Diese Nachricht wurde von meinem Android-Mobiltelefon mit K-9 Mail gesendet.

1 0

[libvirt-users] Finding out CPU topology.
by Peeyush Gupta 17 Sep '13

17 Sep '13

Hi all, I have been trying to find out cpu topology using libvirt. When I do 'virsh capabilites', I find this inside <topology> tag: <topology> <cells num='1'> <cell id='0'> <memory unit='KiB'>3908488</memory> <cpus num='4'> <cpu id='0' socket_id='0' core_id='0' siblings='0'/> <cpu id='1' socket_id='0' core_id='0' siblings='1'/> <cpu id='2' socket_id='0' core_id='1' siblings='2'/> <cpu id='3' socket_id='0' core_id='1' siblings='3'/> </cpus> </cell> </cells> </topology> But when I use the 'getCapbilities()' function of the python binding, the result is: <topology> <cells num='1'> <cell id='0'> <cpus num='4'> <cpu id='0'/> <cpu id='1'/> <cpu id='2'/> <cpu id='3'/> </cpus> </cell> </cells> </topology>\n As you can see this doesnt give any information about socket/core/thread etc. What I an interested to know is that is it a limitation of python binding or libvirt C API itself? How can I get the whole topology without just parsing the output of virsh capabilities? Thanks. ~Peeyush Gupta

2 2

[libvirt-users] Regarding libvirt usage
by Manzoor Ahamed 16 Sep '13

16 Sep '13

Hi Team, I am using libvirt module to retrieve configuration of the virtual machines, Can you please tell me how to retrieve the disk space of the Virtual machines. In my KVM hyper i am running two virtual machines. Regards Manzoor

3 4

[libvirt-users] Doc: How to use NPIV in libvirt
by Osier Yang 12 Sep '13

12 Sep '13

Before posting it to WIKI or somewhere, I want to see if there is any suggestions on it, or if I missed something. ============================================ How to use NPIV in libvirt I planned to wrote a document about how to use NPIV in libvirt after more features are supported, but it looks like I can't wait till then, got lots lots of questions from both the bugs and mails. So here we go. The document tries to summary up the things about NPIV that libvirt supports till now, and the TODO list. Feedback or suggestion is welcomed. 1) How to find out which HBA(s) support vHBA For libvirt newer than "1.0.4", you can find it out simply by: # virsh nodedev-list --cap vports "--cap vports" is to tell "nodedev-list" only outputs the devices which support "vports" capability, i.e. support vHBA. And also since version "1.0.4", you should be able to know the maximum vports the HBA supports and the current vports number from the HBA's XML, e.g. # virsh nodedev-dumpxml scsi_host5 <device> <name>scsi_host5</name> <parent>pci_0000_04_00_1</parent> <capability type='scsi_host'> <host>5</host> <capability type='fc_host'> <wwnn>2001001b32a9da4e</wwnn> <wwpn>2101001b32a9da4e</wwpn> <fabric_wwn>2001000dec9877c1</fabric_wwn> </capability> <capability type='vport_ops'> <max_vports>164</max_vports> <vports>5</vports> </capability> </capability> </device> For libvirt older than "1.0.4", it's a bit complicated than above: First you need to find out all the HBAs, e.g. # virsh nodedev-list --cap scsi_host scsi_host0 scsi_host1 scsi_host2 scsi_host3 scsi_host4 scsi_host5 And then, to see if the HBA supports vHBA, check if the dumped XML contains "vport_ops" capability. E.g. # virsh nodedev-dumpxml scsi_host3 <device> <name>scsi_host3</name> <parent>pci_0000_00_08_0</parent> <capability type='scsi_host'> <host>3</host> </capability> </device> That says "scsi_host3" doesn't support vHBA # virsh nodedev-dumpxml scsi_host5 <device> <name>scsi_host5</name> <parent>pci_0000_04_00_1</parent> <capability type='scsi_host'> <host>5</host> <capability type='fc_host'> <wwnn>2001001b32a9da4e</wwnn> <wwpn>2101001b32a9da4e</wwpn> <fabric_wwn>2001000dec9877c1</fabric_wwn> </capability> <capability type='vport_ops' /> </capability> </device> But "scsi_host5" supports it. One might be confused with the node device naming style (e.g. scsi_host5) in this document and RHEL6 Virtualization Guide [1] (pci_10df_fe00_scsi_host_0). It's because of libvirt has two backends for node device driver: udev and HAL. We prefer the udev backend more than HAL backend in internal implementation, I think there is good enough reason to do so (HAL is maintenance mode now). I believe udev backend is used more than HAL backend, but if your destribution packager build libvirt without udev backend, don't be surprised with the node device names like the ones in [1]. 2) How to create a vHBA Pick up one HBA which supports vHBA, use it's "node device name" as the "parent" of vHBA, and specify the "wwnn" and "wwpn" in the vHBA's XML. E.g. <device> <name>scsi_host6</name> <parent>scsi_host5</parent> <capability type='scsi_host'> <capability type='fc_host'> <wwnn>2001001b32a9da5e</wwnn> <wwpn>2101001b32a9da5e</wwpn> </capability> </capability> </device> Then create the vHBA with virsh command "nodedev-create" (assuming above XML file is named "vhba.xml"): # virsh nodedev-create vhba.xml Node device scsi_host6 created from vhba.xml Since "0.9.10", libvirt will generate "wwnn" and "wwpn" automatically if they are not specified. It means one can create the vHBA by a more simple XML like: <device> <parent>scsi_host5</parent> <capability type='scsi_host'> <capability type='fc_host'> </capability> </capability> </device> 3) How to destroy a vHBA As usual, destroying something is always simpler than creating it: # virsh nodedev-destroy scsi_host6 Destroyed node device 'scsi_host6' You might already realize that the vHBA is removed permanently, don't be surprised, it's the life, node device driver doesn't support persistent config. I won't say it's nightmare for users who screams when realizing the vHBA disappeared after a system rebooting, but it's relatively not good, (assuming that you got the wwnn:wwpn pair from the storage admin, but didn't record it). Fortunately, we support the persistent vHBA now, see next section for details. 4) How to create a persistent vHBA Let's go back to the history a bit firstly. Prior to libvirt "1.0.5", one can define a "scsi" type pool based on a (v)HBA by it's scsi host name (e.g. "host5" in XML below). E.g. <pool type='scsi'> <name>poolhba0</name> <uuid>e9392370-2917-565e-692b-d057f46512d6</uuid> <capacity unit='bytes'>0</capacity> <allocation unit='bytes'>0</allocation> <available unit='bytes'>0</available> <source> <adapter name='host0'/> </source> <target> <path>/dev/disk/by-path</path> <permissions> <mode>0700</mode> <owner>0</owner> <group>0</group> </permissions> </target> </pool> Quite nice? yeah, at least it looks so, but the problem is the scsi host number is *unstable* (it can be changed after system rebooting, or kernel module reloading, or a vHBA recreating etc), and thus the "scsi" type pool based on a (v)HBA becomes unstable too. Obviously it doesn't help on the "persistent vHBA" problem. To solve the problems, since libvirt "1.0.5", we introduced new XML schema to indicate the (v)HBA. An example of the XML: <pool type='scsi'> <name>poolvhba0</name> <uuid>e9392370-2917-565e-692b-d057f46512d6</uuid> <source> <adapter type='fc_host' parent='scsi_host5' wwnn='20000000c9831b4b' wwpn='10000000c9831b4b'/> </source> <target> <path>/dev/disk/by-path</path> <permissions> <mode>0700</mode> <owner>0</owner> <group>0</group> </permissions> </target> </pool> It allows to define a "scsi" type pool based on either a HBA or a vHBA. For HBA, "parent" attribute can be omitted. For vHBA, if "parent" is not specified, libvirt will pick up the first HBA which supports vHBA, and doesn't exceed the maximum vports it supports, automatically. For the pool based on a vHBA, When the pool is starting, libvirt will check if the specified vHBA (wwnn:wwpn) is existing on host or not, if it doesn't exist yet, libvirt will create it automatically. When the pool is being stopped, the vHBA is destroyed. But since storage driver supports the persistent config, one can easily gets the vHBA with same "wwnn:wwpn" in next starting (Don't scream if your pool is transient). It's not the end if you want to get the vHBA created automatically after system rebooting, you will need to set the pool as "autostart": # virsh pool-autostart poolvhba0 One might be curious about why not to support persistent config for node device driver, and support to create persistent vHBA there. One of the reason is that it will be duplicate with what storage pool does. And another reason (the important one) is we want to assiciate the libvirt storage pool/volume with domain (see section "Use LUN for guest" below). 5) How to find out the LUN's path If you have defined the "scsi" type pool based on the (v)HBA, it's simple to lookup what LUNs attached to the (v)HBA by virsh command "vol-list", e.g. # virsh vol-list poolvhba0 --details Name Path Type Capacity Allocation -------------------------------------------------------------------------------------------------------- unit:0:2:0 /dev/disk/by-path/pci-0000:04:00.1-fc-0x203500a0b85ad1d7-lun-0 block 20.01 GiB 20.01 GiB If you have not defined a "scsi" type pool based on the (v)HBA, you can find it out (v)HBA by either virsh command "nodedev-list --tree", or iterating sysfs manually. To find out the LUNs by virsh command "nodedev-list" (irrelevant ouputs are omitted): # virsh nodedev-list --tree +- pci_0000_00_0d_0 | | | +- pci_0000_04_00_0 | | | | | +- scsi_host4 | | | +- pci_0000_04_00_1 | | | +- scsi_host5 | | | +- scsi_host7 | +- scsi_target5_0_0 | | | | | +- scsi_5_0_0_0 | | | +- scsi_target5_0_1 | | | | | +- scsi_5_0_1_0 | | | +- scsi_target5_0_2 | | | | | +- scsi_5_0_2_0 | | | | | +- block_sdb_3600a0b80005adb0b0000ab2d4cae9254 | | | +- scsi_target5_0_3 | | | +- scsi_5_0_3_0 "scsi_host5" is an HBA on my host, it has a LUN named "block_sdb_3600a0b80005adb0b0000ab2d4cae9254", don't be confused with the naming, it's the naming style libvirt uses, meaningful only for libvirt. It indicates the LUN has a short device path "/dev/sdb", and a ID "3600a0b80005adb0b0000ab2d4cae9254": # ls /dev/disk/by-id/ | grep 3600a0b80005adb0b0000ab2d4cae9254 scsi-3600a0b80005adb0b0000ab2d4cae9254 To manually find the LUNs of a (v)HBA: First, you need to iterate over all the directores begins with the SCSI scsi host number of the v(HBA) under "/sys/bus/scsi/devices". E.g. I will look up the LUNs of the HBA with SCSI host number 5 on my host: # ls /sys/bus/scsi/devices/5:* -d /sys/bus/scsi/devices/5:0:0:0 /sys/bus/scsi/devices/5:0:1:0 /sys/bus/scsi/devices/5:0:2:0 /sys/bus/scsi/devices/5:0:3:0 # ls /sys/bus/scsi/devices/5\:0\:3\:0/block/sdc It means scsi_host5 has a LUN attached with device name "sdc" on address "5:0:3:0". # ls /sys/bus/scsi/devices/5\:0\:1\:0/ | grep block device_blocked scsi_host5 doesn't have a LUN attached on address "5:0:2:0" The device name like "sdc" is not stable, to find out the stable path, find out the symbol link which points to the device name. E.g. # ls -l /dev/disk/by-path/ lrwxrwxrwx. 1 root root 9 Sep 10 22:28 pci-0000:00:07.0-scsi-0:0:0:0 -> ../../sda lrwxrwxrwx. 1 root root 10 Sep 10 22:28 pci-0000:00:07.0-scsi-0:0:0:0-part1 -> ../../sda1 lrwxrwxrwx. 1 root root 9 Sep 10 22:28 pci-0000:04:00.1-fc-0x203400a0b85ad1d7-lun-0 -> ../../sdc Then "/dev/disk/by-path/pci-0000:04:00.1-fc-0x203400a0b85ad1d7-lun-0" is the stable path of the LUN attached to address "5:0:3:0". Of course, you can use the similiar method to get the "by-id | by-uuid | by-label" stable path. 6) Use the LUN to guest Since libvirt "1.0.5", we supported to use the storage volume as disk source by two new attributes ("pool" and "volume") for disk "<source"> element. E.g. <disk type='volume' device='disk'> <driver name='qemu' type='raw'/> <source pool='poolvhba0' volume='unit:0:2:0 '/> <target dev='hda' bus='ide'/> </disk> There are lots of advantage to do so. Since the mainly purpose of the document is about "how to use", I will only mention two here to persuade you using the it. First, you don't need to look up the LUN's path youself. Second, assuming that you want to migrate a domain which uses a LUN attached to a vHBA, do you want to create the vHBA manually on target host? With the pool, you can simply define/start a pool with same config on target host. So, if your libvirt is newer than "1.0.5", we recommend you to define the "scsi" type pool based on the (v)HBA, and use "pool/volume" names to use the LUN as disk source. You can either use the LUN as qemu emulated disk, or passthrough it to guest. To use it as qemu emulated disk, specifying the "device" attribute as "device='disk|cdrom|floppy'". E.g. <disk type='volume' device='disk'> <driver name='qemu' type='raw'/> <source pool='blk-pool0' volume='blk-pool0-vol0'/> <target dev='hda' bus='ide'/> </disk> Or (using the LUN's path directly) <disk type='volume' device='disk'> <driver name='qemu' type='raw'/> <source dev='/dev/disk/by-path/pci-0000\:04\:00.1-fc-0x203400a0b85ad1d7-lun-0'/> <target dev='sda' bus='scsi'/> </disk> To passthrough the LUN, specifying the "device" attribute as "device='lun'", e.g. <disk type='volume' device='lun'> <driver name='qemu' type='raw'/> <source dev='/dev/disk/by-path/pci-0000\:04\:00.1-fc-0x203400a0b85ad1d7-lun-0'/> <target dev='sda' bus='scsi'/> </disk> 6) Future work * NPIV based SCSI host passthrough That's what the users ask: How to passthrough a (v)HBA to guest? * Expose vendor information, LUN's path, state of (v)HBA in its XML * May be a virsh command to simplify vHBA creation with options [1] http://www.linuxtopia.org/online_books/rhel6/rhel_6_virtualization/rhel_6_v… Regards, Osier

2 1

Re: [libvirt-users] Questions on how to reset ID numbers for virt Guests.
by Paolo Bonzini 11 Sep '13

11 Sep '13

Il 11/09/2013 00:27, James Sparenberg ha scritto: > I'm doing some experimenting in our Development lab and as a result > I'm kickstarting over and over Virtual guests. This is of course > causing the guest Id to increment by one with each test. I've > googled around and tried searching the list but have not found out > how (if at all) it would be possible to reset the ID number back to 1 > more than is in use. Also is there a limit where I run out of ID's? > (for example does it only go up to 99?) No, there is no limit. I don't know the answer to your other question, so I'm adding the libvirt-users mailing list. Paolo

4 3

[libvirt-users] libvirt-1.2.2-r1 (Gentoo) fails to start LXC containers
by Dennis Jenkins 11 Sep '13

11 Sep '13

I recently upgraded "libvirt" on Gentoo to 1.2.2-r1 (latest available). I have not used LXC containers for a few weeks, so I don't recall what version of libvirt I was using when my container last booted successfully. Unfortunately, Gentoo's portage tree does not offer any previous versions of libvirt that I could downgrade to. TL;DR: My container is configured to use "br0" for its networking. "br0" exists totally inside my linux server - it is NOT bound to any physical NIC. "br0" is used for most of my QEMU and LXC VMs. libvirt is reporting that it cannot find device "veth1". All of my Gentoo packages are up-to-date. Digging through my logs (/var/log/libvirt/libvirt.log), I see that I last successfully booted this LXC container on 2013-07-22, with libvirt reporting version "1.1.0". Thoughts? ostara lxc # equery l libvirt * Searching for libvirt ... [IP-] [ ] app-emulation/libvirt-1.1.2-r1:0 ostara lxc # uname -a Linux ostara 3.10.7-gentoo #2 SMP PREEMPT Sat Aug 24 16:03:57 CDT 2013 x86_64 Intel(R) Core(TM) i5 CPU 760 @ 2.80GHz GenuineIntel GNU/Linux ostara ~ # emerge -pvuND world These are the packages that would be merged, in order: Calculating dependencies... done! Total: 0 packages, Size of downloads: 0 kB ostara lxc # virsh -c lxc:/// start dwj-hfax-dev error: Failed to start domain dwj-hfax-dev error: internal error: guest failed to start: PATH=/bin:/sbin TERM=linux container=lxc-libvirt container_uuid=681410de-7b56-41bd-b38d-3c66ce97e7b3 LIBVIRT_LXC_UUID=681410de-7b56-41bd-b38d-3c66ce97e7b3 LIBVIRT_LXC_NAME=dwj-hfax-dev /sbin/init error receiving signal from container: Input/output error ostara ~ # tail /var/log/libvirt/lxc/dwj-hfax-dev.log 2013-09-10 13:56:22.767+0000: starting up PATH=/bin:/sbin:/bin:/sbin:/usr/bin:/usr/sbin:/usr/bin:/usr/sbin:/usr/local/bin:/usr/local/sbin:/opt/bin:/usr/x86_64-pc-linux-gnu/gcc-bin/4.6.3:/usr/x86_64-pc-linux-gnu/i686-pc-mingw32/gcc-bin/4.7.3 LIBVIRT_DEBUG=3 LIBVIRT_LOG_OUTPUTS=3:file:/var/log/libvirt/libvirtd.log /usr/libexec/libvirt_lxc --name dwj-hfax-dev --console 20 --security=none --handshake 23 --background --veth veth1 PATH=/bin:/sbin TERM=linux container=lxc-libvirt container_uuid=681410de-7b56-41bd-b38d-3c66ce97e7b3 LIBVIRT_LXC_UUID=681410de-7b56-41bd-b38d-3c66ce97e7b3 LIBVIRT_LXC_NAME=dwj-hfax-dev /sbin/init error receiving signal from container: Input/output error ostara ~ # tail /var/log/libvirt/libvirtd.log 2013-09-10 13:56:22.998+0000: 12948: info : libvirt version: 1.1.2 2013-09-10 13:56:22.998+0000: 12948: error : virLXCControllerRun:2186 : error receiving signal from container: Input/output error 2013-09-10 13:56:23.053+0000: 12948: error : virCommandWait:2348 : internal error: Child process (ip link del veth1) unexpected exit status 1: Cannot find device "veth1" 2013-09-10 13:56:23.097+0000: 10451: error : virNetSocketReadWire:1369 : Cannot recv data: Connection reset by peer 2013-09-10 13:56:23.153+0000: 10453: error : virLXCProcessStart:1234 : internal error: guest failed to start: PATH=/bin:/sbin TERM=linux container=lxc-libvirt container_uuid=681410de-7b56-41bd-b38d-3c66ce97e7b3 LIBVIRT_LXC_UUID=681410de-7b56-41bd-b38d-3c66ce97e7b3 LIBVIRT_LXC_NAME=dwj-hfax-dev /sbin/init error receiving signal from container: Input/output error 2013-09-10 13:56:23.343+0000: 10453: error : virCommandWait:2348 : internal error: Child process (ip link del veth1) unexpected exit status 1: Cannot find device "veth1" (first occurrence of "veth1" in my libvirtd logs) ostara ~ # grep -a veth1 /var/log/libvirt/libvirtd.log | head -1 2013-09-10 13:51:55.333+0000: 9742: error : virCommandWait:2348 : internal error: Child process (ip link del veth1) unexpected exit status 1: Cannot find device "veth1" ostara ~ # which ip /bin/ip ostara ~ # equery b /bin/ip * Searching for /bin/ip ... sys-apps/iproute2-3.8.0 (/bin/ip) ostara ~ # ls -l /bin/ip -rwxr-xr-x 1 root root 282616 May 4 04:08 /bin/ip ostara ~ # ifconfig -a | grep "^[a-z]" br0: flags=4355<UP,BROADCAST,PROMISC,MULTICAST> mtu 1500 br1: flags=4419<UP,BROADCAST,RUNNING,PROMISC,MULTICAST> mtu 1500 enp4s0: flags=4163<UP,BROADCAST,RUNNING,MULTICAST> mtu 1500 enp5s0: flags=4163<UP,BROADCAST,RUNNING,MULTICAST> mtu 1500 enp6s2: flags=4163<UP,BROADCAST,RUNNING,MULTICAST> mtu 1500 lo: flags=73<UP,LOOPBACK,RUNNING> mtu 65536 virbr0: flags=4099<UP,BROADCAST,MULTICAST> mtu 1500 ostara ~ # virsh -c lxc:/// dumpxml dwj-hfax-dev <domain type='lxc'> <name>dwj-hfax-dev</name> <uuid>681410de-7b56-41bd-b38d-3c66ce97e7b3</uuid> <memory unit='KiB'>4194304</memory> <currentMemory unit='KiB'>4194304</currentMemory> <vcpu placement='static'>4</vcpu> <resource> <partition>/machine</partition> </resource> <os> <type arch='x86_64'>exe</type> <init>/sbin/init</init> </os> <clock offset='utc'/> <on_poweroff>destroy</on_poweroff> <on_reboot>restart</on_reboot> <on_crash>destroy</on_crash> <devices> <emulator>/usr/libexec/libvirt_lxc</emulator> <filesystem type='mount' accessmode='passthrough'> <source dir='/vm/lxc/dwj-hfax-dev'/> <target dir='/'/> </filesystem> <filesystem type='mount' accessmode='passthrough'> <source dir='/usr/portage'/> <target dir='/usr/portage'/> </filesystem> <filesystem type='mount' accessmode='passthrough'> <source dir='/usr/src'/> <target dir='/usr/src'/> </filesystem> <filesystem type='mount' accessmode='passthrough'> <source dir='/home'/> <target dir='/home'/> </filesystem> <interface type='bridge'> <mac address='82:00:00:00:01:01'/> <source bridge='br0'/> </interface> <console type='pty'> <target type='lxc' port='0'/> </console> </devices> </domain>

4 5

[libvirt-users] Help needed in simulating libvirt
by Arun Viswanath 11 Sep '13

11 Sep '13

Hi All, I'm need to simulate libvirt API's say to mock the libvirt API responses. (Actually I need to simulate qemu API's response). Because of my project needs I need to write this simulated libvirt server in Java. I believe the simulated libvirt can be written as java RPC which should capable to receive the client RPC request calls and by dispatcher we can dispatch to the simulated java functions. I searched for .x file to be used for generating server stubs but unfortunately .x files like "remote_protocol.x", "virnetprotocol.x", "qemu_protocol.x" and "lxc_monitor_protocol.x" are not containing any procedure for libvirt API's that exposed. Please let me know which files will have these exposed procedures and how can I use it in java, Also I'm not sure how to implement the ssl layer support for the libvirt server in java. I need to write a java server in such a way that python client should capable to create a connection with uri "qemu+tls://systemip:port?no_tty=1". Also with the created connection object it should able to call the libvirt API's like getCapabilities, etc. Any help and ideas on this will be really helpful. Thanks in Advance, Arun V

3 6

Re: [libvirt-users] libvirt-1.1.2-r1 (Gentoo) fails to start LXC containers (subject line minor edit, was libvirt-1.2.2-r1)
by Dennis Jenkins 10 Sep '13

10 Sep '13

On Tue, Sep 10, 2013 at 1:34 PM, Doug Goldstein <cardoe(a)gentoo.org> wrote: > On Tue, Sep 10, 2013 at 9:09 AM, Dennis Jenkins > <dennis.jenkins.75(a)gmail.com> wrote: > > Yeah our security people got a bit over zealous. That's being rectified. > > :) > > > > TL;DR: My container is configured to use "br0" for its networking. "br0" > > exists totally inside my linux server - it is NOT bound to any physical > NIC. > > "br0" is used for most of my QEMU and LXC VMs. libvirt is reporting > that it > > cannot find device "veth1". All of my Gentoo packages are up-to-date. > > > > Digging through my logs (/var/log/libvirt/libvirt.log), I see that I last > > successfully booted this LXC container on 2013-07-22, with libvirt > reporting > > version "1.1.0". > > > > Thoughts? > > You really need to look at /var/log/libvirt/lxc/dwj-hfax-dev.log > > I did. I thought that I posted the relevant bits. I'll check/repost. It just lots of this (one set from each test that I did): 2013-09-10 13:56:22.767+0000: starting up PATH=/bin:/sbin:/bin:/sbin:/usr/bin:/usr/sbin:/usr/bin:/usr/sbin:/usr/local/bin:/usr/local/sbin:/opt/bin:/usr/x86_64-pc-linux-gnu/gcc-bin/4.6.3:/usr/x86_64-pc-linux-gnu/i686-pc-mingw32/gcc-bin/4.7.3 LIBVIRT_DEBUG=3 LIBVIRT_LOG_OUTPUTS=3:file:/var/log/libvirt/libvirtd.log /usr/libexec/libvirt_lxc --name dwj-hfax-dev --console 20 --security=none --handshake 23 --background --veth veth1 PATH=/bin:/sbin TERM=linux container=lxc-libvirt container_uuid=681410de-7b56-41bd-b38d-3c66ce97e7b3 LIBVIRT_LXC_UUID=681410de-7b56-41bd-b38d-3c66ce97e7b3 LIBVIRT_LXC_NAME=dwj-hfax-dev /sbin/init error receiving signal from container: Input/output error I see the "--veth veth1", which is the same of the NIC that cannot be found. But that NIC is not listed in my domain config XML. > A suggestion would be to make sure that you have all the necessary > kernel options enabled. You can check with: ebuild > /usr/portage/app-emulation/libvirt/libvirt-1.1.2-r1.ebuild setup clean > > No errors. ostara ~ # ebuild /usr/portage/app-emulation/libvirt/libvirt-1.1.2-r1.ebuild setup clean * libvirt-1.1.2.tar.gz SHA256 SHA512 WHIRLPOOL size ;-) ... [ ok ] * libvirt-1.1.2-e89bdf01.tar.xz SHA256 SHA512 WHIRLPOOL size ;-) ... [ ok ] * checking ebuild checksums ;-) ... [ ok ] * checking auxfile checksums ;-) ... [ ok ] * checking miscfile checksums ;-) ... [ ok ] * Determining the location of the kernel source code * Found kernel source directory: * /usr/src/linux * Found kernel object directory: * /lib/modules/3.10.7-gentoo/build * Found sources for kernel version: * 3.10.7-gentoo * Checking for suitable kernel configuration options... [ ok ] 16 days ago, I updated from kernel 3.8.13 to 3.10.7. I could take a brief outage and down-grade my kernel if you think that is a worthy test. I just realized that when I composed my original email/bug report, that I misquoted the version of libvirt that I am running. I am indeed running "1.1.2-r1", but posted as "1.2.2-r1". ostara ~ # virsh version --daemon Compiled against library: libvirt 1.1.2 Using library: libvirt 1.1.2 Using API: QEMU 1.1.2 Running hypervisor: QEMU 1.5.2 Running against daemon: 1.1.2

1 2

[libvirt-users] how to setup network filter
by Jiaan Zeng 10 Sep '13

10 Sep '13

Hi All, I am new to libvirt and encounter a strange problem to set up network filter in a NAT network. I launched VMs in a single host using NAT, i.e. interface type='network'. Now I want to control the outbound traffic from VM instance - only allow the VM to asses a set of ip addresses. My network filter xml is as follows. The problem is once I change the VM xml, shutdown and start VM, VM cannot get ip address. /var/log/libvirt/libvirt.log shows " error : virNetDevGetIndex:656 : Unable to get index for interface vnet2: No such device" error. But when I remove the drop rule in the filter xml, VM can get IP address. I even tried the clean-traffic filter shipped with libvirt. VM throws the same error above. Any idea why this happens? How can I implement outbound traffic control in libvirt? Thanks a lot. <filter name='filter-test'> <rule action='accept' direction='in' priority='500'> <tcp dstportstart='22'/> </rule> <rule action='accept' direction='out' priority='500'> <ip dstipaddr='IP1'/> </rule> <rule action='accept' direction='out' priority='500'> <ip dstipaddr='IP2'/> </rule> <rule action='drop' direction='out' priority='500'> <all/> </rule> </filter> The VM network section XML looks like this <interface type='network'> <mac address='52:54:00:0d:f1:ce'/> <source network='default'/> <filterref filter='filter-test'/> <address type='pci' domain='0x0000' bus='0x00' slot='0x03' function='0x0'/> </interface> -- Regards, Jiaan

2 1