Attachment 608486 Details for Bug 853369 – libvirt.log

libvirt.log

libvirt.log (text/plain), 40.58 KB, created by Richard W.M. Jones on 2012-08-31 11:18:27 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Richard W.M. Jones

Created: 2012-08-31 11:18:27 UTC

Size: 40.58 KB

patch

obsolete

>2012-08-31 11:09:35.517+0000: 21704: info : libvirt version: 0.10.0, package: 1.fc19 (Fedora Project, 2012-08-29-06:39:57, )
>2012-08-31 11:09:35.517+0000: 21704: debug : virInitialize:421 : register drivers
>2012-08-31 11:09:35.517+0000: 21704: debug : virRegisterDriver:729 : driver=0x7fbf3a4e2040 name=Test
>2012-08-31 11:09:35.517+0000: 21704: debug : virRegisterDriver:744 : registering Test as driver 0
>2012-08-31 11:09:35.517+0000: 21704: debug : virRegisterNetworkDriver:561 : registering Test as network driver 0
>2012-08-31 11:09:35.517+0000: 21704: debug : virRegisterInterfaceDriver:591 : registering Test as interface driver 0
>2012-08-31 11:09:35.517+0000: 21704: debug : virRegisterStorageDriver:621 : registering Test as storage driver 0
>2012-08-31 11:09:35.517+0000: 21704: debug : virRegisterDeviceMonitor:651 : registering Test as device driver 0
>2012-08-31 11:09:35.517+0000: 21704: debug : virRegisterSecretDriver:681 : registering Test as secret driver 0
>2012-08-31 11:09:35.517+0000: 21704: debug : virRegisterNWFilterDriver:711 : registering Test as network filter driver 0
>2012-08-31 11:09:35.518+0000: 21704: debug : virRegisterDriver:729 : driver=0x7fbf3a4e3ca0 name=OPENVZ
>2012-08-31 11:09:35.518+0000: 21704: debug : virRegisterDriver:744 : registering OPENVZ as driver 1
>2012-08-31 11:09:35.518+0000: 21704: debug : virRegisterDriver:729 : driver=0x7fbf3a4e4220 name=VMWARE
>2012-08-31 11:09:35.518+0000: 21704: debug : virRegisterDriver:744 : registering VMWARE as driver 2
>2012-08-31 11:09:35.518+0000: 21704: debug : virRegisterDriver:729 : driver=0x7fbf3a4e3520 name=PHYP
>2012-08-31 11:09:35.518+0000: 21704: debug : virRegisterDriver:744 : registering PHYP as driver 3
>2012-08-31 11:09:35.518+0000: 21704: debug : virRegisterStorageDriver:621 : registering PHYP as storage driver 1
>2012-08-31 11:09:35.518+0000: 21704: debug : virRegisterInterfaceDriver:591 : registering PHYP as interface driver 1
>2012-08-31 11:09:35.518+0000: 21704: debug : vboxRegister:131 : VBoxCGlueInit failed, using dummy driver
>2012-08-31 11:09:35.518+0000: 21704: debug : virRegisterDriver:729 : driver=0x7fbf3a4e47a0 name=VBOX
>2012-08-31 11:09:35.518+0000: 21704: debug : virRegisterDriver:744 : registering VBOX as driver 4
>2012-08-31 11:09:35.518+0000: 21704: debug : virRegisterNetworkDriver:561 : registering VBOX as network driver 1
>2012-08-31 11:09:35.518+0000: 21704: debug : virRegisterStorageDriver:621 : registering VBOX as storage driver 2
>2012-08-31 11:09:35.518+0000: 21704: debug : virRegisterDriver:729 : driver=0x7fbf3a4e7a20 name=ESX
>2012-08-31 11:09:35.518+0000: 21704: debug : virRegisterDriver:744 : registering ESX as driver 5
>2012-08-31 11:09:35.518+0000: 21704: debug : virRegisterInterfaceDriver:591 : registering ESX as interface driver 2
>2012-08-31 11:09:35.518+0000: 21704: debug : virRegisterNetworkDriver:561 : registering ESX as network driver 2
>2012-08-31 11:09:35.518+0000: 21704: debug : virRegisterStorageDriver:621 : registering ESX as storage driver 3
>2012-08-31 11:09:35.518+0000: 21704: debug : virRegisterDeviceMonitor:651 : registering ESX as device driver 1
>2012-08-31 11:09:35.518+0000: 21704: debug : virRegisterSecretDriver:681 : registering ESX as secret driver 1
>2012-08-31 11:09:35.518+0000: 21704: debug : virRegisterNWFilterDriver:711 : registering ESX as network filter driver 1
>2012-08-31 11:09:35.518+0000: 21704: debug : virRegisterDriver:729 : driver=0x7fbf3a4e8360 name=Hyper-V
>2012-08-31 11:09:35.518+0000: 21704: debug : virRegisterDriver:744 : registering Hyper-V as driver 6
>2012-08-31 11:09:35.518+0000: 21704: debug : virRegisterInterfaceDriver:591 : registering Hyper-V as interface driver 3
>2012-08-31 11:09:35.518+0000: 21704: debug : virRegisterNetworkDriver:561 : registering Hyper-V as network driver 3
>2012-08-31 11:09:35.518+0000: 21704: debug : virRegisterStorageDriver:621 : registering Hyper-V as storage driver 4
>2012-08-31 11:09:35.519+0000: 21704: debug : virRegisterDeviceMonitor:651 : registering Hyper-V as device driver 2
>2012-08-31 11:09:35.519+0000: 21704: debug : virRegisterSecretDriver:681 : registering Hyper-V as secret driver 2
>2012-08-31 11:09:35.519+0000: 21704: debug : virRegisterNWFilterDriver:711 : registering Hyper-V as network filter driver 2
>2012-08-31 11:09:35.519+0000: 21704: debug : parallelsRegister:1714 : Can't find prlctl command in the PATH env
>2012-08-31 11:09:35.519+0000: 21704: debug : virRegisterDriver:729 : driver=0x7fbf3a4e2980 name=remote
>2012-08-31 11:09:35.519+0000: 21704: debug : virRegisterDriver:744 : registering remote as driver 7
>2012-08-31 11:09:35.519+0000: 21704: debug : virRegisterNetworkDriver:561 : registering remote as network driver 4
>2012-08-31 11:09:35.519+0000: 21704: debug : virRegisterInterfaceDriver:591 : registering remote as interface driver 4
>2012-08-31 11:09:35.519+0000: 21704: debug : virRegisterStorageDriver:621 : registering remote as storage driver 5
>2012-08-31 11:09:35.519+0000: 21704: debug : virRegisterDeviceMonitor:651 : registering remote as device driver 3
>2012-08-31 11:09:35.519+0000: 21704: debug : virRegisterSecretDriver:681 : registering remote as secret driver 3
>2012-08-31 11:09:35.519+0000: 21704: debug : virRegisterNWFilterDriver:711 : registering remote as network filter driver 3
>2012-08-31 11:09:35.520+0000: 21704: debug : virGetVersion:888 : libVir=0x7fff999808b8, type=(null), typeVer=(nil)
>2012-08-31 11:09:35.520+0000: 21704: debug : virConnectOpen:1331 : name=(null)
>2012-08-31 11:09:35.520+0000: 21704: debug : virObjectNew:110 : OBJECT_NEW: obj=0x1b0b640 classname=virConnect
>2012-08-31 11:09:35.521+0000: 21704: debug : do_open:1131 : no name, allowing driver auto-select
>2012-08-31 11:09:35.521+0000: 21704: debug : do_open:1174 : trying driver 0 (Test) ...
>2012-08-31 11:09:35.521+0000: 21704: debug : do_open:1180 : driver 0 Test returned DECLINED
>2012-08-31 11:09:35.521+0000: 21704: debug : do_open:1174 : trying driver 1 (OPENVZ) ...
>2012-08-31 11:09:35.521+0000: 21704: debug : do_open:1180 : driver 1 OPENVZ returned DECLINED
>2012-08-31 11:09:35.521+0000: 21704: debug : do_open:1174 : trying driver 2 (VMWARE) ...
>2012-08-31 11:09:35.521+0000: 21704: debug : do_open:1180 : driver 2 VMWARE returned DECLINED
>2012-08-31 11:09:35.521+0000: 21704: debug : do_open:1174 : trying driver 3 (PHYP) ...
>2012-08-31 11:09:35.521+0000: 21704: debug : do_open:1180 : driver 3 PHYP returned DECLINED
>2012-08-31 11:09:35.521+0000: 21704: debug : do_open:1174 : trying driver 4 (VBOX) ...
>2012-08-31 11:09:35.521+0000: 21704: debug : do_open:1180 : driver 4 VBOX returned DECLINED
>2012-08-31 11:09:35.521+0000: 21704: debug : do_open:1174 : trying driver 5 (ESX) ...
>2012-08-31 11:09:35.521+0000: 21704: debug : do_open:1180 : driver 5 ESX returned DECLINED
>2012-08-31 11:09:35.521+0000: 21704: debug : do_open:1174 : trying driver 6 (Hyper-V) ...
>2012-08-31 11:09:35.521+0000: 21704: debug : do_open:1180 : driver 6 Hyper-V returned DECLINED
>2012-08-31 11:09:35.521+0000: 21704: debug : do_open:1174 : trying driver 7 (remote) ...
>2012-08-31 11:09:35.521+0000: 21704: debug : remoteOpen:945 : Auto-probe remote URI
>2012-08-31 11:09:35.521+0000: 21704: debug : remoteOpen:948 : Auto-spawn user daemon instance
>2012-08-31 11:09:35.521+0000: 21704: debug : doRemoteOpen:576 : proceeding with name = 
>2012-08-31 11:09:35.521+0000: 21704: debug : doRemoteOpen:585 : Connecting with transport 1
>2012-08-31 11:09:35.521+0000: 21704: debug : doRemoteOpen:661 : Proceeding with sockname /run/user/1000/libvirt/libvirt-sock
>2012-08-31 11:09:35.521+0000: 21704: debug : virNetSocketNewConnectUNIX:553 : Connection refused for /run/user/1000/libvirt/libvirt-sock, trying to spawn /usr/sbin/libvirtd
>2012-08-31 11:09:35.521+0000: 21704: debug : virCommandRunAsync:2196 : About to run LC_ALL=C LD_LIBRARY_PATH=/home/rjones/d/libguestfs/src/.libs:/home/rjones/d/libguestfs/gobject/.libs:/home/rjones/d/libguestfs/ruby/ext/guestfs PATH=/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/home/rjones/.local/bin:/home/rjones/bin HOME=/home/rjones USER=rjones LOGNAME=rjones TMPDIR=/home/rjones/d/libguestfs XDG_RUNTIME_DIR=/run/user/1000 /usr/sbin/libvirtd --timeout=30
>2012-08-31 11:09:35.524+0000: 21704: debug : virFileClose:72 : Closed fd 6
>2012-08-31 11:09:35.524+0000: 21704: debug : virCommandRunAsync:2214 : Command result 0, with PID 21755
>2012-08-31 11:09:35.529+0000: 21756: info : libvirt version: 0.10.0, package: 1.fc19 (Fedora Project, 2012-08-29-06:39:57, )
>2012-08-31 11:09:35.529+0000: 21756: debug : virCommandHook:2115 : Hook is done 0
>2012-08-31 11:09:35.531+0000: 21704: debug : virCommandRun:2012 : Result status 0, stdout: '(null)' stderr: '(null)'
>2012-08-31 11:09:35.631+0000: 21704: debug : virNetSocketNew:146 : localAddr=0x7fff99980320 remoteAddr=0x7fff999803b0 fd=5 errfd=-1 pid=0
>2012-08-31 11:09:35.631+0000: 21704: debug : virObjectNew:110 : OBJECT_NEW: obj=0x1b0bc40 classname=virNetSocket
>2012-08-31 11:09:35.631+0000: 21704: debug : virNetSocketNew:203 : RPC_SOCKET_NEW: sock=0x1b0bc40 fd=5 errfd=-1 pid=0 localAddr=127.0.0.1;0, remoteAddr=127.0.0.1;0
>2012-08-31 11:09:35.631+0000: 21704: debug : virObjectNew:110 : OBJECT_NEW: obj=0x1b0b780 classname=virNetClient
>2012-08-31 11:09:35.631+0000: 21704: debug : virNetClientNew:342 : RPC_CLIENT_NEW: client=0x1b0b780 sock=0x1b0bc40
>2012-08-31 11:09:35.631+0000: 21704: debug : virObjectRef:168 : OBJECT_REF: obj=0x1b0b780
>2012-08-31 11:09:35.631+0000: 21704: debug : virObjectRef:168 : OBJECT_REF: obj=0x1b0bc40
>2012-08-31 11:09:35.631+0000: 21704: debug : virNetSocketAddIOCallback:1544 : Failed to register watch on socket 0x1b0bc40
>2012-08-31 11:09:35.631+0000: 21704: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x1b0bc40
>2012-08-31 11:09:35.631+0000: 21704: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x1b0b780
>2012-08-31 11:09:35.631+0000: 21704: error : virNetClientRegisterAsyncIO:542 : internal error Unable to register async IO callback
>2012-08-31 11:09:35.631+0000: 21704: debug : doRemoteOpen:730 : Failed to add event watch, disabling events and support for keepalive messages
>2012-08-31 11:09:35.631+0000: 21704: debug : virObjectNew:110 : OBJECT_NEW: obj=0x1b0b990 classname=virNetClientProgram
>2012-08-31 11:09:35.631+0000: 21704: debug : virObjectNew:110 : OBJECT_NEW: obj=0x1b0ce30 classname=virNetClientProgram
>2012-08-31 11:09:35.631+0000: 21704: debug : virObjectRef:168 : OBJECT_REF: obj=0x1b0b990
>2012-08-31 11:09:35.631+0000: 21704: debug : virObjectRef:168 : OBJECT_REF: obj=0x1b0ce30
>2012-08-31 11:09:35.631+0000: 21704: debug : doRemoteOpen:759 : Trying authentication
>2012-08-31 11:09:35.631+0000: 21704: debug : virNetMessageNew:45 : msg=0x1b0d060 tracked=0
>2012-08-31 11:09:35.633+0000: 21704: debug : virNetMessageEncodePayload:358 : Encode length as 28
>2012-08-31 11:09:35.634+0000: 21704: debug : virNetClientSendInternal:1952 : RPC_CLIENT_MSG_TX_QUEUE: client=0x1b0b780 len=28 prog=536903814 vers=1 proc=66 type=0 status=0 serial=0
>2012-08-31 11:09:35.634+0000: 21704: debug : virNetClientCallNew:1905 : New call 0x1b0bb00: msg=0x1b0d060, expectReply=1, nonBlock=0
>2012-08-31 11:09:35.634+0000: 21704: debug : virNetClientIO:1715 : Outgoing message prog=536903814 version=1 serial=0 proc=66 type=0 length=28 dispatch=(nil)
>2012-08-31 11:09:35.634+0000: 21704: debug : virNetClientIO:1774 : We have the buck head=0x1b0bb00 call=0x1b0bb00
>2012-08-31 11:09:35.634+0000: 21704: debug : virNetSocketUpdateIOCallback:1565 : Watch not registered on socket 0x1b0bc40
>2012-08-31 11:09:37.851+0000: 21704: debug : virNetMessageDecodeLength:152 : Got length, now need 36 total (32 more)
>2012-08-31 11:09:37.852+0000: 21704: debug : virNetClientCallDispatch:1127 : RPC_CLIENT_MSG_RX: client=0x1b0b780 len=36 prog=536903814 vers=1 proc=66 type=1 status=0 serial=0
>2012-08-31 11:09:37.852+0000: 21704: debug : virKeepAliveCheckMessage:384 : ka=(nil), client=0x7fbf3a254d77, msg=0x1b0b7e8
>2012-08-31 11:09:37.852+0000: 21704: debug : virNetClientIOEventLoopPassTheBuck:1421 : Giving up the buck 0x1b0bb00
>2012-08-31 11:09:37.852+0000: 21704: debug : virNetClientIOEventLoopPassTheBuck:1435 : No thread to pass the buck to
>2012-08-31 11:09:37.852+0000: 21704: debug : virNetSocketUpdateIOCallback:1565 : Watch not registered on socket 0x1b0bc40
>2012-08-31 11:09:37.852+0000: 21704: debug : virNetClientIO:1804 : All done with our call head=(nil) call=0x1b0bb00 rv=0
>2012-08-31 11:09:37.852+0000: 21704: debug : virNetMessageFree:73 : msg=0x1b0d060 nfds=0 cb=(nil)
>2012-08-31 11:09:37.852+0000: 21704: debug : doRemoteOpen:785 : Trying to open URI 
>2012-08-31 11:09:37.852+0000: 21704: debug : virNetMessageNew:45 : msg=0x1b0ccd0 tracked=0
>2012-08-31 11:09:37.854+0000: 21704: debug : virNetMessageEncodePayload:358 : Encode length as 40
>2012-08-31 11:09:37.854+0000: 21704: debug : virNetClientSendInternal:1952 : RPC_CLIENT_MSG_TX_QUEUE: client=0x1b0b780 len=40 prog=536903814 vers=1 proc=1 type=0 status=0 serial=1
>2012-08-31 11:09:37.854+0000: 21704: debug : virNetClientCallNew:1905 : New call 0x1b0cfb0: msg=0x1b0ccd0, expectReply=1, nonBlock=0
>2012-08-31 11:09:37.854+0000: 21704: debug : virNetClientIO:1715 : Outgoing message prog=536903814 version=1 serial=1 proc=1 type=0 length=40 dispatch=(nil)
>2012-08-31 11:09:37.854+0000: 21704: debug : virNetClientIO:1774 : We have the buck head=0x1b0cfb0 call=0x1b0cfb0
>2012-08-31 11:09:37.854+0000: 21704: debug : virNetSocketUpdateIOCallback:1565 : Watch not registered on socket 0x1b0bc40
>2012-08-31 11:09:37.864+0000: 21704: debug : virNetMessageDecodeLength:152 : Got length, now need 28 total (24 more)
>2012-08-31 11:09:37.865+0000: 21704: debug : virNetClientCallDispatch:1127 : RPC_CLIENT_MSG_RX: client=0x1b0b780 len=28 prog=536903814 vers=1 proc=1 type=1 status=0 serial=1
>2012-08-31 11:09:37.865+0000: 21704: debug : virKeepAliveCheckMessage:384 : ka=(nil), client=0x7fbf3a254d77, msg=0x1b0b7e8
>2012-08-31 11:09:37.865+0000: 21704: debug : virNetClientIOEventLoopPassTheBuck:1421 : Giving up the buck 0x1b0cfb0
>2012-08-31 11:09:37.865+0000: 21704: debug : virNetClientIOEventLoopPassTheBuck:1435 : No thread to pass the buck to
>2012-08-31 11:09:37.865+0000: 21704: debug : virNetSocketUpdateIOCallback:1565 : Watch not registered on socket 0x1b0bc40
>2012-08-31 11:09:37.865+0000: 21704: debug : virNetClientIO:1804 : All done with our call head=(nil) call=0x1b0cfb0 rv=0
>2012-08-31 11:09:37.865+0000: 21704: debug : virNetMessageFree:73 : msg=0x1b0ccd0 nfds=0 cb=(nil)
>2012-08-31 11:09:37.865+0000: 21704: debug : doRemoteOpen:796 : Trying to query remote URI
>2012-08-31 11:09:37.865+0000: 21704: debug : virNetMessageNew:45 : msg=0x1b0bb00 tracked=0
>2012-08-31 11:09:37.865+0000: 21704: debug : virNetMessageEncodePayload:358 : Encode length as 28
>2012-08-31 11:09:37.865+0000: 21704: debug : virNetClientSendInternal:1952 : RPC_CLIENT_MSG_TX_QUEUE: client=0x1b0b780 len=28 prog=536903814 vers=1 proc=110 type=0 status=0 serial=2
>2012-08-31 11:09:37.865+0000: 21704: debug : virNetClientCallNew:1905 : New call 0x1b0cdc0: msg=0x1b0bb00, expectReply=1, nonBlock=0
>2012-08-31 11:09:37.865+0000: 21704: debug : virNetClientIO:1715 : Outgoing message prog=536903814 version=1 serial=2 proc=110 type=0 length=28 dispatch=(nil)
>2012-08-31 11:09:37.865+0000: 21704: debug : virNetClientIO:1774 : We have the buck head=0x1b0cdc0 call=0x1b0cdc0
>2012-08-31 11:09:37.865+0000: 21704: debug : virNetSocketUpdateIOCallback:1565 : Watch not registered on socket 0x1b0bc40
>2012-08-31 11:09:37.866+0000: 21704: debug : virNetMessageDecodeLength:152 : Got length, now need 48 total (44 more)
>2012-08-31 11:09:37.866+0000: 21704: debug : virNetClientCallDispatch:1127 : RPC_CLIENT_MSG_RX: client=0x1b0b780 len=48 prog=536903814 vers=1 proc=110 type=1 status=0 serial=2
>2012-08-31 11:09:37.866+0000: 21704: debug : virKeepAliveCheckMessage:384 : ka=(nil), client=0x7fbf3a254d77, msg=0x1b0b7e8
>2012-08-31 11:09:37.866+0000: 21704: debug : virNetClientIOEventLoopPassTheBuck:1421 : Giving up the buck 0x1b0cdc0
>2012-08-31 11:09:37.866+0000: 21704: debug : virNetClientIOEventLoopPassTheBuck:1435 : No thread to pass the buck to
>2012-08-31 11:09:37.866+0000: 21704: debug : virNetSocketUpdateIOCallback:1565 : Watch not registered on socket 0x1b0bc40
>2012-08-31 11:09:37.866+0000: 21704: debug : virNetClientIO:1804 : All done with our call head=(nil) call=0x1b0cdc0 rv=0
>2012-08-31 11:09:37.866+0000: 21704: debug : virNetMessageFree:73 : msg=0x1b0bb00 nfds=0 cb=(nil)
>2012-08-31 11:09:37.866+0000: 21704: debug : doRemoteOpen:804 : Auto-probed URI is qemu:///session
>2012-08-31 11:09:37.866+0000: 21704: debug : do_open:1180 : driver 7 remote returned SUCCESS
>2012-08-31 11:09:37.866+0000: 21704: debug : do_open:1202 : network driver 0 Test returned DECLINED
>2012-08-31 11:09:37.866+0000: 21704: debug : do_open:1202 : network driver 1 VBOX returned DECLINED
>2012-08-31 11:09:37.866+0000: 21704: debug : do_open:1202 : network driver 2 ESX returned DECLINED
>2012-08-31 11:09:37.866+0000: 21704: debug : do_open:1202 : network driver 3 Hyper-V returned DECLINED
>2012-08-31 11:09:37.866+0000: 21704: debug : do_open:1202 : network driver 4 remote returned SUCCESS
>2012-08-31 11:09:37.866+0000: 21704: debug : do_open:1217 : interface driver 0 Test returned DECLINED
>2012-08-31 11:09:37.866+0000: 21704: debug : do_open:1217 : interface driver 1 PHYP returned DECLINED
>2012-08-31 11:09:37.866+0000: 21704: debug : do_open:1217 : interface driver 2 ESX returned DECLINED
>2012-08-31 11:09:37.866+0000: 21704: debug : do_open:1217 : interface driver 3 Hyper-V returned DECLINED
>2012-08-31 11:09:37.866+0000: 21704: debug : do_open:1217 : interface driver 4 remote returned SUCCESS
>2012-08-31 11:09:37.866+0000: 21704: debug : do_open:1233 : storage driver 0 Test returned DECLINED
>2012-08-31 11:09:37.866+0000: 21704: debug : do_open:1233 : storage driver 1 PHYP returned DECLINED
>2012-08-31 11:09:37.866+0000: 21704: debug : do_open:1233 : storage driver 2 VBOX returned DECLINED
>2012-08-31 11:09:37.866+0000: 21704: debug : do_open:1233 : storage driver 3 ESX returned DECLINED
>2012-08-31 11:09:37.866+0000: 21704: debug : do_open:1233 : storage driver 4 Hyper-V returned DECLINED
>2012-08-31 11:09:37.866+0000: 21704: debug : do_open:1233 : storage driver 5 remote returned SUCCESS
>2012-08-31 11:09:37.866+0000: 21704: debug : do_open:1249 : node driver 0 Test returned DECLINED
>2012-08-31 11:09:37.866+0000: 21704: debug : do_open:1249 : node driver 1 ESX returned DECLINED
>2012-08-31 11:09:37.866+0000: 21704: debug : do_open:1249 : node driver 2 Hyper-V returned DECLINED
>2012-08-31 11:09:37.866+0000: 21704: debug : do_open:1249 : node driver 3 remote returned SUCCESS
>2012-08-31 11:09:37.866+0000: 21704: debug : do_open:1265 : secret driver 0 Test returned DECLINED
>2012-08-31 11:09:37.867+0000: 21704: debug : do_open:1265 : secret driver 1 ESX returned DECLINED
>2012-08-31 11:09:37.867+0000: 21704: debug : do_open:1265 : secret driver 2 Hyper-V returned DECLINED
>2012-08-31 11:09:37.867+0000: 21704: debug : do_open:1265 : secret driver 3 remote returned SUCCESS
>2012-08-31 11:09:37.867+0000: 21704: debug : do_open:1281 : nwfilter driver 0 Test returned DECLINED
>2012-08-31 11:09:37.867+0000: 21704: debug : do_open:1281 : nwfilter driver 1 ESX returned DECLINED
>2012-08-31 11:09:37.867+0000: 21704: debug : do_open:1281 : nwfilter driver 2 Hyper-V returned DECLINED
>2012-08-31 11:09:37.867+0000: 21704: debug : do_open:1281 : nwfilter driver 3 remote returned SUCCESS
>2012-08-31 11:09:37.867+0000: 21704: debug : virConnectGetCapabilities:6415 : conn=0x1b0b640
>2012-08-31 11:09:37.867+0000: 21704: debug : virNetMessageNew:45 : msg=0x1b0d720 tracked=0
>2012-08-31 11:09:37.867+0000: 21704: debug : virNetMessageEncodePayload:358 : Encode length as 28
>2012-08-31 11:09:37.867+0000: 21704: debug : virNetClientSendInternal:1952 : RPC_CLIENT_MSG_TX_QUEUE: client=0x1b0b780 len=28 prog=536903814 vers=1 proc=7 type=0 status=0 serial=3
>2012-08-31 11:09:37.867+0000: 21704: debug : virNetClientCallNew:1905 : New call 0x1b0ced0: msg=0x1b0d720, expectReply=1, nonBlock=0
>2012-08-31 11:09:37.867+0000: 21704: debug : virNetClientIO:1715 : Outgoing message prog=536903814 version=1 serial=3 proc=7 type=0 length=28 dispatch=(nil)
>2012-08-31 11:09:37.867+0000: 21704: debug : virNetClientIO:1774 : We have the buck head=0x1b0ced0 call=0x1b0ced0
>2012-08-31 11:09:37.867+0000: 21704: debug : virNetSocketUpdateIOCallback:1565 : Watch not registered on socket 0x1b0bc40
>2012-08-31 11:09:39.126+0000: 21704: debug : virNetMessageDecodeLength:152 : Got length, now need 8892 total (8888 more)
>2012-08-31 11:09:39.127+0000: 21704: debug : virNetClientCallDispatch:1127 : RPC_CLIENT_MSG_RX: client=0x1b0b780 len=8892 prog=536903814 vers=1 proc=7 type=1 status=0 serial=3
>2012-08-31 11:09:39.127+0000: 21704: debug : virKeepAliveCheckMessage:384 : ka=(nil), client=0x7fbf3a254d77, msg=0x1b0b7e8
>2012-08-31 11:09:39.127+0000: 21704: debug : virNetClientIOEventLoopPassTheBuck:1421 : Giving up the buck 0x1b0ced0
>2012-08-31 11:09:39.127+0000: 21704: debug : virNetClientIOEventLoopPassTheBuck:1435 : No thread to pass the buck to
>2012-08-31 11:09:39.127+0000: 21704: debug : virNetSocketUpdateIOCallback:1565 : Watch not registered on socket 0x1b0bc40
>2012-08-31 11:09:39.127+0000: 21704: debug : virNetClientIO:1804 : All done with our call head=(nil) call=0x1b0ced0 rv=0
>2012-08-31 11:09:39.127+0000: 21704: debug : virNetMessageFree:73 : msg=0x1b0d720 nfds=0 cb=(nil)
>2012-08-31 11:09:39.127+0000: 21704: debug : virConnectGetCapabilities:6430 : conn=0x1b0b640 ret=<capabilities>
>
>  <host>
>    <uuid>9c013b63-debd-62d1-607f-25dd4bec6595</uuid>
>    <cpu>
>      <arch>x86_64</arch>
>      <model>Westmere</model>
>      <vendor>Intel</vendor>
>      <topology sockets='1' cores='4' threads='2'/>
>      <feature name='rdtscp'/>
>      <feature name='avx'/>
>      <feature name='osxsave'/>
>      <feature name='xsave'/>
>      <feature name='tsc-deadline'/>
>      <feature name='pdcm'/>
>      <feature name='xtpr'/>
>      <feature name='tm2'/>
>      <feature name='est'/>
>      <feature name='vmx'/>
>      <feature name='ds_cpl'/>
>      <feature name='monitor'/>
>      <feature name='dtes64'/>
>      <feature name='pclmuldq'/>
>      <feature name='pbe'/>
>      <feature name='tm'/>
>      <feature name='ht'/>
>      <feature name='ss'/>
>      <feature name='acpi'/>
>      <feature name='ds'/>
>      <feature name='vme'/>
>    </cpu>
>    <power_management>
>      <suspend_mem/>
>      <suspend_disk/>
>    </power_management>
>    <migration_features>
>      <live/>
>      <uri_transports>
>        <uri_transport>tcp</uri_transport>
>      </uri_transports>
>    </migration_features>
>    <topology>
>      <cells num='1'>
>        <cell id='0'>
>          <cpus num='8'>
>            <cpu id='0'/>
>            <cpu id='1'/>
>            <cpu id='2'/>
>            <cpu id='3'/>
>            <cpu id='4'/>
>            <cpu id='5'/>
>            <cpu id='6'/>
>            <cpu id='7'/>
>          </cpus>
>        </cell>
>      </cells>
>    </topology>
>    <secmodel>
>      <model>selinux</model>
>      <doi>0</doi>
>    </secmodel>
>  </host>
>
>  <guest>
>    <os_type>hvm</os_type>
>    <arch name='i686'>
>      <wordsize>32</wordsize>
>      <emulator>/bin/qemu-system-x86_64</emulator>
>      <machine>pc-1.2</machine>
>      <machine>none</machine>
>      <machine canonical='pc-1.2'>pc</machine>
>      <machine>pc-1.1</machine>
>      <machine>pc-1.0</machine>
>      <machine>pc-0.15</machine>
>      <machine>pc-0.14</machine>
>      <machine>pc-0.13</machine>
>      <machine>pc-0.12</machine>
>      <machine>pc-0.11</machine>
>      <machine>pc-0.10</machine>
>      <machine>isapc</machine>
>      <domain type='qemu'>
>      </domain>
>      <domain type='kvm'>
>        <emulator>/bin/qemu-kvm</emulator>
>        <machine>pc-1.2</machine>
>        <machine>none</machine>
>        <machine canonical='pc-1.2'>pc</machine>
>        <machine>pc-1.1</machine>
>        <machine>pc-1.0</machine>
>        <machine>pc-0.15</machine>
>        <machine>pc-0.14</machine>
>        <machine>pc-0.13</machine>
>        <machine>pc-0.12</machine>
>        <machine>pc-0.11</machine>
>        <machine>pc-0.10</machine>
>        <machine>isapc</machine>
>      </domain>
>    </arch>
>    <features>
>      <cpuselection/>
>      <deviceboot/>
>      <pae/>
>      <nonpae/>
>      <acpi default='on' toggle='yes'/>
>      <apic default='on' toggle='no'/>
>    </features>
>  </guest>
>
>  <guest>
>    <os_type>hvm</os_type>
>    <arch name='x86_64'>
>      <wordsize>64</wordsize>
>      <emulator>/bin/qemu-system-x86_64</emulator>
>      <machine>pc-1.2</machine>
>      <machine>none</machine>
>      <machine canonical='pc-1.2'>pc</machine>
>      <machine>pc-1.1</machine>
>      <machine>pc-1.0</machine>
>      <machine>pc-0.15</machine>
>      <machine>pc-0.14</machine>
>      <machine>pc-0.13</machine>
>      <machine>pc-0.12</machine>
>      <machine>pc-0.11</machine>
>      <machine>pc-0.10</machine>
>      <machine>isapc</machine>
>      <domain type='qemu'>
>      </domain>
>      <domain type='kvm'>
>        <emulator>/bin/qemu-kvm</emulator>
>        <machine>pc-1.2</machine>
>        <machine>none</machine>
>        <machine canonical='pc-1.2'>pc</machine>
>        <machine>pc-1.1</machine>
>        <machine>pc-1.0</machine>
>        <machine>pc-0.15</machine>
>        <machine>pc-0.14</machine>
>        <machine>pc-0.13</machine>
>        <machine>pc-0.12</machine>
>        <machine>pc-0.11</machine>
>        <machine>pc-0.10</machine>
>        <machine>isapc</machine>
>      </domain>
>    </arch>
>    <features>
>      <cpuselection/>
>      <deviceboot/>
>      <acpi default='on' toggle='yes'/>
>      <apic default='on' toggle='no'/>
>    </features>
>  </guest>
>
>  <guest>
>    <os_type>hvm</os_type>
>    <arch name='arm'>
>      <wordsize>32</wordsize>
>      <emulator>/bin/qemu-system-arm</emulator>
>      <machine>integratorcp</machine>
>      <machine>none</machine>
>      <machine>collie</machine>
>      <machine>nuri</machine>
>      <machine>smdkc210</machine>
>      <machine>connex</machine>
>      <machine>verdex</machine>
>      <machine>highbank</machine>
>      <machine>kzm</machine>
>      <machine>mainstone</machine>
>      <machine>musicpal</machine>
>      <machine>n800</machine>
>      <machine>n810</machine>
>      <machine>sx1</machine>
>      <machine>sx1-v1</machine>
>      <machine>cheetah</machine>
>      <machine>realview-eb</machine>
>      <machine>realview-eb-mpcore</machine>
>      <machine>realview-pb-a8</machine>
>      <machine>realview-pbx-a9</machine>
>      <machine>akita</machine>
>      <machine>spitz</machine>
>      <machine>borzoi</machine>
>      <machine>terrier</machine>
>      <machine>lm3s811evb</machine>
>      <machine>lm3s6965evb</machine>
>      <machine>tosa</machine>
>      <machine>versatilepb</machine>
>      <machine>versatileab</machine>
>      <machine>vexpress-a9</machine>
>      <machine>vexpress-a15</machine>
>      <machine>xilinx-zynq-a9</machine>
>      <machine>z2</machine>
>      <domain type='qemu'>
>      </domain>
>      <domain type='kvm'>
>        <emulator>/bin/qemu-system-arm</emulator>
>      </domain>
>    </arch>
>    <features>
>      <deviceboot/>
>    </features>
>  </guest>
>
>  <guest>
>    <os_type>hvm</os_type>
>    <arch name='mips'>
>      <wordsize>32</wordsize>
>      <emulator>/bin/qemu-system-mips</emulator>
>      <machine>malta</machine>
>      <machine>none</machine>
>      <machine>magnum</machine>
>      <machine>pica61</machine>
>      <machine>mipssim</machine>
>      <machine>mips</machine>
>      <domain type='qemu'>
>      </domain>
>      <domain type='kvm'>
>        <emulator>/bin/qemu-system-mips</emulator>
>      </domain>
>    </arch>
>    <features>
>      <deviceboot/>
>    </features>
>  </guest>
>
>  <guest>
>    <os_type>hvm</os_type>
>    <arch name='mipsel'>
>      <wordsize>32</wordsize>
>      <emulator>/bin/qemu-system-mipsel</emulator>
>      <machine>malta</machine>
>      <machine>none</machine>
>      <machine>magnum</machine>
>      <machine>pica61</machine>
>      <machine>mipssim</machine>
>      <machine>mips</machine>
>      <domain type='qemu'>
>      </domain>
>      <domain type='kvm'>
>        <emulator>/bin/qemu-system-mipsel</emulator>
>      </domain>
>    </arch>
>    <features>
>      <deviceboot/>
>    </features>
>  </guest>
>
>  <guest>
>    <os_type>hvm</os_type>
>    <arch name='sparc'>
>      <wordsize>32</wordsize>
>      <emulator>/bin/qemu-system-sparc</emulator>
>      <machine>SS-5</machine>
>      <machine>none</machine>
>      <machine>leon3_generic</machine>
>      <machine>SS-10</machine>
>      <machine>SS-600MP</machine>
>      <machine>SS-20</machine>
>      <machine>Voyager</machine>
>      <machine>LX</machine>
>      <machine>SS-4</machine>
>      <machine>SPARCClassic</machine>
>      <machine>SPARCbook</machine>
>      <machine>SS-1000</machine>
>      <machine>SS-2000</machine>
>      <machine>SS-2</machine>
>      <domain type='qemu'>
>      </domain>
>      <domain type='kvm'>
>        <emulator>/bin/qemu-system-sparc</emulator>
>      </domain>
>    </arch>
>  </guest>
>
>  <guest>
>    <os_type>hvm</os_type>
>    <arch name='ppc'>
>      <wordsize>32</wordsize>
>      <emulator>/bin/qemu-system-ppc</emulator>
>      <machine>g3beige</machine>
>      <machine>none</machine>
>      <machine>ref405ep</machine>
>      <machine>taihu</machine>
>      <machine>bamboo</machine>
>      <machine>mac99</machine>
>      <machine>prep</machine>
>      <machine>virtex-ml507</machine>
>      <machine>ppce500</machine>
>      <machine>mpc8544ds</machine>
>      <domain type='qemu'>
>      </domain>
>      <domain type='kvm'>
>        <emulator>/bin/qemu-system-ppc</emulator>
>      </domain>
>    </arch>
>    <features>
>      <deviceboot/>
>    </features>
>  </guest>
>
>  <guest>
>    <os_type>hvm</os_type>
>    <arch name='ppc64'>
>      <wordsize>64</wordsize>
>      <emulator>/bin/qemu-system-ppc64</emulator>
>      <machine>mac99</machine>
>      <machine>none</machine>
>      <machine>ref405ep</machine>
>      <machine>taihu</machine>
>      <machine>bamboo</machine>
>      <machine>g3beige</machine>
>      <machine>prep</machine>
>      <machine>pseries</machine>
>      <machine>virtex-ml507</machine>
>      <machine>ppce500</machine>
>      <machine>mpc8544ds</machine>
>      <domain type='qemu'>
>      </domain>
>      <domain type='kvm'>
>        <emulator>/bin/qemu-system-ppc64</emulator>
>      </domain>
>    </arch>
>    <features>
>      <cpuselection/>
>      <deviceboot/>
>    </features>
>  </guest>
>
></capabilities>
>
>2012-08-31 11:09:39.412+0000: 21704: debug : virDomainCreateXML:1934 : conn=0x1b0b640, xmlDesc=<?xml version="1.0"?>
><domain type="kvm" xmlns:qemu="http://libvirt.org/schemas/domain/qemu/1.0">
>  <name>guestfs-o2tr4x2b3ug71anh</name>
>  <memory unit="MiB">500</memory>
>  <currentMemory unit="MiB">500</currentMemory>
>  <cpu model="host-model"/>
>  <vcpu>1</vcpu>
>  <clock offset="utc"/>
>  <os>
>    <type>hvm</type>
>    <kernel>/home/rjones/d/libguestfs/.guestfs-1000/kernel.21704</kernel>
>    <initrd>/home/rjones/d/libguestfs/.guestfs-1000/initrd.21704</initrd>
>    <cmdline>panic=1 console=ttyS0 udevtimeout=600 no_timer_check acpi=off printk.time=1 cgroup_disable=memory root=/dev/sdb selinux=0 guestfs_verbose=1 TERM=xterm </cmdline>
>  </os>
>  <seclabel type="none"/>
>  <on_reboot>destroy</on_reboot>
>  <devices>
>    <controller type="scsi" index="0" model="virtio-scsi"/>
>    <disk device="disk" type="file">
>      <source file="/tmp/libguestfs-test-tool-sda-LHXYOz"/>
>      <target dev="sda" bus="scsi"/>
>      <driver name="qemu" type="raw"/>
>      <address type="drive" controller="0" bus="0" target="0" unit="0"/>
>    </disk>
>    <disk type="file" device="disk">
>      <source file="/home/rjones/d/libguestfs/.guestfs-1000/root.21704"/>
>      <target dev="sdb" bus="scsi"/>
>      <driver name="qemu" type="raw" cache="unsafe"/>
>      <address type="drive" controller="0" bus="0" target="1" unit="0"/>
>    </disk>
>    <serial type="unix">
>      <source mode="connect" path="/home/rjones/d/libguestfs/libguestfsZQ4qcp/console.sock"/>
>      <target port="0"/>
>    </serial>
>    <channel type="unix">
>      <source mode="connect" path="/home/rjones/d/libguestfs/libguestfsZQ4qcp/guestfsd.sock"/>
>      <target type="virtio" name="org.libguestfs.channel.0"/>
>    </channel>
>  </devices>
>  <qemu:commandline>
>    <qemu:arg value="-set"/>
>    <qemu:arg value="drive.drive-scsi0-0-1-0.snapshot=on"/>
>  </qemu:commandline>
></domain>
>, flags=2
>2012-08-31 11:09:39.412+0000: 21704: debug : virNetMessageNew:45 : msg=0x1b0b4e0 tracked=0
>2012-08-31 11:09:39.414+0000: 21704: debug : virNetMessageEncodePayload:358 : Encode length as 1872
>2012-08-31 11:09:39.414+0000: 21704: debug : virNetClientSendInternal:1952 : RPC_CLIENT_MSG_TX_QUEUE: client=0x1b0b780 len=1872 prog=536903814 vers=1 proc=10 type=0 status=0 serial=4
>2012-08-31 11:09:39.414+0000: 21704: debug : virNetClientCallNew:1905 : New call 0x1b0cdb0: msg=0x1b0b4e0, expectReply=1, nonBlock=0
>2012-08-31 11:09:39.414+0000: 21704: debug : virNetClientIO:1715 : Outgoing message prog=536903814 version=1 serial=4 proc=10 type=0 length=1872 dispatch=(nil)
>2012-08-31 11:09:39.414+0000: 21704: debug : virNetClientIO:1774 : We have the buck head=0x1b0cdb0 call=0x1b0cdb0
>2012-08-31 11:09:39.414+0000: 21704: debug : virNetSocketUpdateIOCallback:1565 : Watch not registered on socket 0x1b0bc40
>2012-08-31 11:09:40.412+0000: 21704: debug : virNetMessageDecodeLength:152 : Got length, now need 76 total (72 more)
>2012-08-31 11:09:40.412+0000: 21704: debug : virNetClientCallDispatch:1127 : RPC_CLIENT_MSG_RX: client=0x1b0b780 len=76 prog=536903814 vers=1 proc=10 type=1 status=0 serial=4
>2012-08-31 11:09:40.412+0000: 21704: debug : virKeepAliveCheckMessage:384 : ka=(nil), client=0x7fbf3a254d77, msg=0x1b0b7e8
>2012-08-31 11:09:40.412+0000: 21704: debug : virNetClientIOEventLoopPassTheBuck:1421 : Giving up the buck 0x1b0cdb0
>2012-08-31 11:09:40.412+0000: 21704: debug : virNetClientIOEventLoopPassTheBuck:1435 : No thread to pass the buck to
>2012-08-31 11:09:40.412+0000: 21704: debug : virNetSocketUpdateIOCallback:1565 : Watch not registered on socket 0x1b0bc40
>2012-08-31 11:09:40.412+0000: 21704: debug : virNetClientIO:1804 : All done with our call head=(nil) call=0x1b0cdb0 rv=0
>2012-08-31 11:09:40.412+0000: 21704: debug : virNetMessageFree:73 : msg=0x1b0b4e0 nfds=0 cb=(nil)
>2012-08-31 11:09:40.412+0000: 21704: debug : virObjectNew:110 : OBJECT_NEW: obj=0x1b0cd40 classname=virDomain
>2012-08-31 11:09:40.412+0000: 21704: debug : virObjectRef:168 : OBJECT_REF: obj=0x1b0b640
>2012-08-31 11:09:47.763+0000: 21704: debug : virDomainDestroyFlags:2235 : dom=0x1b0cd40, (VM: name=guestfs-o2tr4x2b3ug71anh, uuid=19ac95bf-0da3-9175-edf0-acdf7e2db3b2), flags=0
>2012-08-31 11:09:47.763+0000: 21704: debug : virNetMessageNew:45 : msg=0x1b0b4e0 tracked=0
>2012-08-31 11:09:47.764+0000: 21704: debug : virNetMessageEncodePayload:358 : Encode length as 80
>2012-08-31 11:09:47.764+0000: 21704: debug : virNetClientSendInternal:1952 : RPC_CLIENT_MSG_TX_QUEUE: client=0x1b0b780 len=80 prog=536903814 vers=1 proc=234 type=0 status=0 serial=5
>2012-08-31 11:09:47.764+0000: 21704: debug : virNetClientCallNew:1905 : New call 0x1b0c9b0: msg=0x1b0b4e0, expectReply=1, nonBlock=0
>2012-08-31 11:09:47.764+0000: 21704: debug : virNetClientIO:1715 : Outgoing message prog=536903814 version=1 serial=5 proc=234 type=0 length=80 dispatch=(nil)
>2012-08-31 11:09:47.764+0000: 21704: debug : virNetClientIO:1774 : We have the buck head=0x1b0c9b0 call=0x1b0c9b0
>2012-08-31 11:09:47.764+0000: 21704: debug : virNetSocketUpdateIOCallback:1565 : Watch not registered on socket 0x1b0bc40
>2012-08-31 11:09:48.014+0000: 21704: debug : virNetMessageDecodeLength:152 : Got length, now need 200 total (196 more)
>2012-08-31 11:09:48.014+0000: 21704: debug : virNetClientCallDispatch:1127 : RPC_CLIENT_MSG_RX: client=0x1b0b780 len=200 prog=536903814 vers=1 proc=234 type=1 status=1 serial=5
>2012-08-31 11:09:48.014+0000: 21704: debug : virKeepAliveCheckMessage:384 : ka=(nil), client=0x7fbf3a254d77, msg=0x1b0b7e8
>2012-08-31 11:09:48.014+0000: 21704: debug : virNetClientIOEventLoopPassTheBuck:1421 : Giving up the buck 0x1b0c9b0
>2012-08-31 11:09:48.014+0000: 21704: debug : virNetClientIOEventLoopPassTheBuck:1435 : No thread to pass the buck to
>2012-08-31 11:09:48.014+0000: 21704: debug : virNetSocketUpdateIOCallback:1565 : Watch not registered on socket 0x1b0bc40
>2012-08-31 11:09:48.014+0000: 21704: debug : virNetClientIO:1804 : All done with our call head=(nil) call=0x1b0c9b0 rv=0
>2012-08-31 11:09:48.015+0000: 21704: error : virNetClientProgramDispatchError:174 : Requested operation is not valid: domain is not running
>2012-08-31 11:09:48.015+0000: 21704: debug : virNetMessageFree:73 : msg=0x1b0b4e0 nfds=0 cb=(nil)
>2012-08-31 11:09:48.015+0000: 21704: debug : virDomainFree:2278 : dom=0x1b0cd40, (VM: name=guestfs-o2tr4x2b3ug71anh, uuid=19ac95bf-0da3-9175-edf0-acdf7e2db3b2)
>2012-08-31 11:09:48.015+0000: 21704: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x1b0cd40
>2012-08-31 11:09:48.015+0000: 21704: debug : virObjectUnref:137 : OBJECT_DISPOSE: obj=0x1b0cd40
>2012-08-31 11:09:48.015+0000: 21704: debug : virDomainDispose:225 : release domain 0x1b0cd40 guestfs-o2tr4x2b3ug71anh 19ac95bf-0da3-9175-edf0-acdf7e2db3b2
>2012-08-31 11:09:48.015+0000: 21704: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x1b0b640
>2012-08-31 11:09:48.015+0000: 21704: debug : virConnectClose:1446 : conn=0x1b0b640
>2012-08-31 11:09:48.015+0000: 21704: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x1b0b640
>2012-08-31 11:09:48.015+0000: 21704: debug : virObjectUnref:137 : OBJECT_DISPOSE: obj=0x1b0b640
>2012-08-31 11:09:48.015+0000: 21704: debug : virNetMessageNew:45 : msg=0x1b0d1d0 tracked=0
>2012-08-31 11:09:48.016+0000: 21704: debug : virNetMessageEncodePayload:358 : Encode length as 28
>2012-08-31 11:09:48.016+0000: 21704: debug : virNetClientSendInternal:1952 : RPC_CLIENT_MSG_TX_QUEUE: client=0x1b0b780 len=28 prog=536903814 vers=1 proc=2 type=0 status=0 serial=6
>2012-08-31 11:09:48.016+0000: 21704: debug : virNetClientCallNew:1905 : New call 0x1b0c9b0: msg=0x1b0d1d0, expectReply=1, nonBlock=0
>2012-08-31 11:09:48.016+0000: 21704: debug : virNetClientIO:1715 : Outgoing message prog=536903814 version=1 serial=6 proc=2 type=0 length=28 dispatch=(nil)
>2012-08-31 11:09:48.016+0000: 21704: debug : virNetClientIO:1774 : We have the buck head=0x1b0c9b0 call=0x1b0c9b0
>2012-08-31 11:09:48.016+0000: 21704: debug : virNetSocketUpdateIOCallback:1565 : Watch not registered on socket 0x1b0bc40
>2012-08-31 11:09:48.017+0000: 21704: debug : virNetMessageDecodeLength:152 : Got length, now need 28 total (24 more)
>2012-08-31 11:09:48.017+0000: 21704: debug : virNetClientCallDispatch:1127 : RPC_CLIENT_MSG_RX: client=0x1b0b780 len=28 prog=536903814 vers=1 proc=2 type=1 status=0 serial=6
>2012-08-31 11:09:48.017+0000: 21704: debug : virKeepAliveCheckMessage:384 : ka=(nil), client=0x7fbf3a254d77, msg=0x1b0b7e8
>2012-08-31 11:09:48.017+0000: 21704: debug : virNetClientIOEventLoopPassTheBuck:1421 : Giving up the buck 0x1b0c9b0
>2012-08-31 11:09:48.017+0000: 21704: debug : virNetClientIOEventLoopPassTheBuck:1435 : No thread to pass the buck to
>2012-08-31 11:09:48.017+0000: 21704: debug : virNetSocketUpdateIOCallback:1565 : Watch not registered on socket 0x1b0bc40
>2012-08-31 11:09:48.017+0000: 21704: debug : virNetClientIO:1804 : All done with our call head=(nil) call=0x1b0c9b0 rv=0
>2012-08-31 11:09:48.017+0000: 21704: debug : virNetMessageFree:73 : msg=0x1b0d1d0 nfds=0 cb=(nil)
>2012-08-31 11:09:48.017+0000: 21704: debug : virNetClientCloseInternal:698 : client=0x1b0b780 wantclose=0
>2012-08-31 11:09:48.018+0000: 21704: debug : virNetClientMarkClose:646 : client=0x1b0b780, reason=3
>2012-08-31 11:09:48.018+0000: 21704: debug : virNetSocketRemoveIOCallback:1580 : Watch not registered on socket 0x1b0bc40
>2012-08-31 11:09:48.018+0000: 21704: debug : virNetClientIOEventLoopPassTheBuck:1421 : Giving up the buck (nil)
>2012-08-31 11:09:48.018+0000: 21704: debug : virNetClientIOEventLoopPassTheBuck:1435 : No thread to pass the buck to
>2012-08-31 11:09:48.018+0000: 21704: debug : virNetClientCloseLocked:659 : client=0x1b0b780, sock=0x1b0bc40, reason=3
>2012-08-31 11:09:48.018+0000: 21704: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x1b0bc40
>2012-08-31 11:09:48.018+0000: 21704: debug : virObjectUnref:137 : OBJECT_DISPOSE: obj=0x1b0bc40
>2012-08-31 11:09:48.018+0000: 21704: debug : virNetSocketDispose:888 : sock=0x1b0bc40 fd=5
>2012-08-31 11:09:48.018+0000: 21704: debug : virFileClose:72 : Closed fd 5
>2012-08-31 11:09:48.018+0000: 21704: debug : virObjectRef:168 : OBJECT_REF: obj=0x1b0b780
>2012-08-31 11:09:48.018+0000: 21704: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x1b0b780
>2012-08-31 11:09:48.018+0000: 21704: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x1b0b780
>2012-08-31 11:09:48.018+0000: 21704: debug : virObjectUnref:137 : OBJECT_DISPOSE: obj=0x1b0b780
>2012-08-31 11:09:48.018+0000: 21704: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x1b0b990
>2012-08-31 11:09:48.018+0000: 21704: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x1b0ce30
>2012-08-31 11:09:48.018+0000: 21704: debug : virFileClose:72 : Closed fd 7
>2012-08-31 11:09:48.018+0000: 21704: debug : virFileClose:72 : Closed fd 6
>2012-08-31 11:09:48.018+0000: 21704: debug : virNetMessageClear:56 : msg=0x1b0b7e8 nfds=0
>2012-08-31 11:09:48.018+0000: 21704: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x1b0b990
>2012-08-31 11:09:48.018+0000: 21704: debug : virObjectUnref:137 : OBJECT_DISPOSE: obj=0x1b0b990
>2012-08-31 11:09:48.018+0000: 21704: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x1b0ce30
>2012-08-31 11:09:48.019+0000: 21704: debug : virObjectUnref:137 : OBJECT_DISPOSE: obj=0x1b0ce30

Actions: View

Attachments on bug 853369: 608486 | 608490