Attachment 918284 Details for Bug 924853 – libvirtd log

libvirtd log

libvirtd.log (text/plain), 162.49 KB, created by Shanzhi Yu on 2014-07-16 02:22:13 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Shanzhi Yu

Created: 2014-07-16 02:22:13 UTC

Size: 162.49 KB

patch

obsolete

>2014-07-16 02:17:32.045+0000: 4378: debug : virEventPollRunOnce:638 : Poll got 1 event(s)
>2014-07-16 02:17:32.046+0000: 4378: debug : virEventPollDispatchTimeouts:423 : Dispatch 1
>2014-07-16 02:17:32.046+0000: 4378: debug : virEventPollDispatchHandles:468 : Dispatch 9
>2014-07-16 02:17:32.046+0000: 4378: debug : virEventPollDispatchHandles:482 : i=0 w=1
>2014-07-16 02:17:32.046+0000: 4378: debug : virEventPollDispatchHandles:482 : i=1 w=2
>2014-07-16 02:17:32.046+0000: 4378: debug : virEventPollDispatchHandles:482 : i=2 w=3
>2014-07-16 02:17:32.046+0000: 4378: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=3 events=1
>2014-07-16 02:17:32.047+0000: 4378: debug : virNetSocketNew:155 : localAddr=0x7fff9d1c35c0 remoteAddr=0x7fff9d1c3650 fd=23 errfd=-1 pid=0
>2014-07-16 02:17:32.047+0000: 4378: debug : virObjectNew:199 : OBJECT_NEW: obj=0x7f5656b34170 classname=virNetSocket
>2014-07-16 02:17:32.047+0000: 4378: debug : virNetSocketNew:205 : RPC_SOCKET_NEW: sock=0x7f5656b34170 fd=23 errfd=-1 pid=0 localAddr=127.0.0.1;0, remoteAddr=127.0.0.1;0
>2014-07-16 02:17:32.047+0000: 4378: debug : virNetServerClientNew:414 : sock=0x7f5656b34170 auth=2 tls=(nil)
>2014-07-16 02:17:32.047+0000: 4378: debug : virObjectNew:199 : OBJECT_NEW: obj=0x7f5656b345f0 classname=virNetServerClient
>2014-07-16 02:17:32.047+0000: 4378: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5656b34170
>2014-07-16 02:17:32.047+0000: 4378: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140008766417024
>2014-07-16 02:17:32.047+0000: 4378: debug : virEventPollAddTimeout:248 : EVENT_POLL_ADD_TIMEOUT: timer=3 frequency=-1 cb=0x7f565434ee80 opaque=0x7f5656b345f0 ff=(nil)
>2014-07-16 02:17:32.047+0000: 4378: debug : virNetMessageNew:44 : msg=0x7f5656b34420 tracked=1
>2014-07-16 02:17:32.047+0000: 4378: debug : virNetServerClientNewInternal:384 : RPC_SERVER_CLIENT_NEW: client=0x7f5656b345f0 sock=0x7f5656b34170
>2014-07-16 02:17:32.047+0000: 4378: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7f5656b34420 tx=(nil)
>2014-07-16 02:17:32.047+0000: 4378: debug : virNetServerClientCalculateHandleMode:188 : mode=1
>2014-07-16 02:17:32.047+0000: 4378: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5656b345f0
>2014-07-16 02:17:32.047+0000: 4378: debug : virNetServerClientRegisterEvent:204 : Registering client event callback 1
>2014-07-16 02:17:32.047+0000: 4378: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5656b34170
>2014-07-16 02:17:32.047+0000: 4378: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140008766417024
>2014-07-16 02:17:32.047+0000: 4378: debug : virEventPollAddHandle:136 : EVENT_POLL_ADD_HANDLE: watch=37 fd=23 events=1 cb=0x7f56543570c0 opaque=0x7f5656b34170 ff=0x7f5654357070
>2014-07-16 02:17:32.047+0000: 4378: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5656b345f0
>2014-07-16 02:17:32.047+0000: 4378: debug : virKeepAliveNew:196 : client=0x7f5656b345f0, interval=5, count=5
>2014-07-16 02:17:32.047+0000: 4378: debug : virObjectNew:199 : OBJECT_NEW: obj=0x7f5656b34b50 classname=virKeepAlive
>2014-07-16 02:17:32.047+0000: 4378: debug : virKeepAliveNew:215 : RPC_KEEPALIVE_NEW: ka=0x7f5656b34b50 client=0x7f5656b345f0
>2014-07-16 02:17:32.047+0000: 4378: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5656b345f0
>2014-07-16 02:17:32.047+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5656b345f0
>2014-07-16 02:17:32.047+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5656b34170
>2014-07-16 02:17:32.047+0000: 4378: debug : virEventPollDispatchHandles:482 : i=3 w=4
>2014-07-16 02:17:32.047+0000: 4378: debug : virEventPollDispatchHandles:482 : i=4 w=5
>2014-07-16 02:17:32.047+0000: 4378: debug : virEventPollDispatchHandles:482 : i=5 w=6
>2014-07-16 02:17:32.047+0000: 4378: debug : virEventPollDispatchHandles:482 : i=7 w=8
>2014-07-16 02:17:32.047+0000: 4378: debug : virEventPollDispatchHandles:482 : i=8 w=9
>2014-07-16 02:17:32.047+0000: 4378: debug : virEventPollDispatchHandles:482 : i=9 w=36
>2014-07-16 02:17:32.047+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 2
>2014-07-16 02:17:32.047+0000: 4378: debug : virEventPollCleanupTimeouts:527 : EVENT_POLL_PURGE_TIMEOUT: timer=1
>2014-07-16 02:17:32.048+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.048+0000: 4378: debug : virEventRunDefaultImpl:270 : running default event implementation
>2014-07-16 02:17:32.048+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 1
>2014-07-16 02:17:32.048+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.048+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0
>2014-07-16 02:17:32.048+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0
>2014-07-16 02:17:32.048+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0
>2014-07-16 02:17:32.048+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0
>2014-07-16 02:17:32.048+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=14 e=1 d=0
>2014-07-16 02:17:32.048+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=13 e=1 d=0
>2014-07-16 02:17:32.048+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0
>2014-07-16 02:17:32.048+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0
>2014-07-16 02:17:32.048+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0
>2014-07-16 02:17:32.048+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=36, f=26 e=25 d=0
>2014-07-16 02:17:32.048+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=10 w=37, f=23 e=1 d=0
>2014-07-16 02:17:32.048+0000: 4378: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 1 timers
>2014-07-16 02:17:32.048+0000: 4378: debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms
>2014-07-16 02:17:32.048+0000: 4378: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=10 timeout=-1
>2014-07-16 02:17:32.048+0000: 4378: debug : virEventPollRunOnce:638 : Poll got 1 event(s)
>2014-07-16 02:17:32.048+0000: 4378: debug : virEventPollDispatchTimeouts:423 : Dispatch 1
>2014-07-16 02:17:32.048+0000: 4378: debug : virEventPollDispatchHandles:468 : Dispatch 10
>2014-07-16 02:17:32.048+0000: 4378: debug : virEventPollDispatchHandles:482 : i=0 w=1
>2014-07-16 02:17:32.048+0000: 4378: debug : virEventPollDispatchHandles:482 : i=1 w=2
>2014-07-16 02:17:32.048+0000: 4378: debug : virEventPollDispatchHandles:482 : i=2 w=3
>2014-07-16 02:17:32.048+0000: 4378: debug : virEventPollDispatchHandles:482 : i=3 w=4
>2014-07-16 02:17:32.048+0000: 4378: debug : virEventPollDispatchHandles:482 : i=4 w=5
>2014-07-16 02:17:32.048+0000: 4378: debug : virEventPollDispatchHandles:482 : i=5 w=6
>2014-07-16 02:17:32.048+0000: 4378: debug : virEventPollDispatchHandles:482 : i=7 w=8
>2014-07-16 02:17:32.048+0000: 4378: debug : virEventPollDispatchHandles:482 : i=8 w=9
>2014-07-16 02:17:32.048+0000: 4378: debug : virEventPollDispatchHandles:482 : i=9 w=36
>2014-07-16 02:17:32.048+0000: 4378: debug : virEventPollDispatchHandles:482 : i=10 w=37
>2014-07-16 02:17:32.048+0000: 4378: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=37 events=1
>2014-07-16 02:17:32.048+0000: 4378: debug : virNetMessageDecodeLength:149 : Got length, now need 28 total (24 more)
>2014-07-16 02:17:32.048+0000: 4378: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7f5656b34420 tx=(nil)
>2014-07-16 02:17:32.048+0000: 4378: debug : virNetServerClientCalculateHandleMode:188 : mode=1
>2014-07-16 02:17:32.048+0000: 4378: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=37 events=1
>2014-07-16 02:17:32.048+0000: 4378: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140008766417024
>2014-07-16 02:17:32.048+0000: 4378: debug : virNetServerClientDispatchRead:1202 : RPC_SERVER_CLIENT_MSG_RX: client=0x7f5656b345f0 len=28 prog=536903814 vers=1 proc=66 type=0 status=0 serial=0
>2014-07-16 02:17:32.048+0000: 4378: debug : virKeepAliveCheckMessage:374 : ka=0x7f5656b34b50, client=0x7f5656b345f0, msg=0x7f5656b34420
>2014-07-16 02:17:32.048+0000: 4378: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5656b345f0
>2014-07-16 02:17:32.048+0000: 4378: debug : virNetServerDispatchNewMessage:214 : server=0x7f5656b24720 client=0x7f5656b345f0 message=0x7f5656b34420
>2014-07-16 02:17:32.048+0000: 4378: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5656b2f100
>2014-07-16 02:17:32.048+0000: 4378: debug : virNetMessageNew:44 : msg=0x7f5656b35af0 tracked=1
>2014-07-16 02:17:32.048+0000: 4378: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7f5656b35af0 tx=(nil)
>2014-07-16 02:17:32.048+0000: 4378: debug : virNetServerClientCalculateHandleMode:188 : mode=1
>2014-07-16 02:17:32.048+0000: 4380: debug : virNetServerHandleJob:185 : server=0x7f5656b24720 client=0x7f5656b345f0 message=0x7f5656b34420 prog=0x7f5656b2f100
>2014-07-16 02:17:32.048+0000: 4378: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=37 events=1
>2014-07-16 02:17:32.048+0000: 4380: debug : virNetServerProgramDispatch:285 : prog=536903814 ver=1 type=0 status=0 serial=0 proc=66
>2014-07-16 02:17:32.048+0000: 4378: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140008766417024
>2014-07-16 02:17:32.048+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 1
>2014-07-16 02:17:32.048+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.048+0000: 4380: debug : virFileClose:90 : Closed fd 24
>2014-07-16 02:17:32.050+0000: 4380: debug : virObjectNew:199 : OBJECT_NEW: obj=0x7f5620000a90 classname=virIdentity
>2014-07-16 02:17:32.050+0000: 4380: debug : virIdentitySetAttr:282 : ident=0x7f5620000a90 attribute=0 value=root
>2014-07-16 02:17:32.050+0000: 4380: debug : virIdentitySetAttr:282 : ident=0x7f5620000a90 attribute=1 value=0
>2014-07-16 02:17:32.050+0000: 4380: debug : virIdentitySetAttr:282 : ident=0x7f5620000a90 attribute=2 value=root
>2014-07-16 02:17:32.050+0000: 4380: debug : virIdentitySetAttr:282 : ident=0x7f5620000a90 attribute=3 value=0
>2014-07-16 02:17:32.050+0000: 4380: debug : virIdentitySetAttr:282 : ident=0x7f5620000a90 attribute=4 value=4678
>2014-07-16 02:17:32.050+0000: 4380: debug : virIdentitySetAttr:282 : ident=0x7f5620000a90 attribute=5 value=324823
>2014-07-16 02:17:32.050+0000: 4380: debug : virIdentitySetAttr:282 : ident=0x7f5620000a90 attribute=8 value=unconfined_u:unconfined_r:unconfined_t:s0-s0:c0.c1023
>2014-07-16 02:17:32.050+0000: 4380: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5620000a90
>2014-07-16 02:17:32.050+0000: 4380: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5620000a90
>2014-07-16 02:17:32.050+0000: 4380: debug : remoteDispatchAuthListHelper:18 : server=0x7f5656b24720 client=0x7f5656b345f0 msg=0x7f5656b34420 rerr=0x7f5644f74c80 args=0x7f5620000900 ret=0x7f56200009a0
>2014-07-16 02:17:32.050+0000: 4378: debug : virEventRunDefaultImpl:270 : running default event implementation
>2014-07-16 02:17:32.050+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 1
>2014-07-16 02:17:32.050+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.050+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0
>2014-07-16 02:17:32.050+0000: 4380: debug : virFileClose:90 : Closed fd 24
>2014-07-16 02:17:32.050+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0
>2014-07-16 02:17:32.050+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0
>2014-07-16 02:17:32.050+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0
>2014-07-16 02:17:32.050+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=14 e=1 d=0
>2014-07-16 02:17:32.050+0000: 4380: info : remoteDispatchAuthList:2377 : Bypass polkit auth for privileged client pid:4678,uid:0
>2014-07-16 02:17:32.050+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=13 e=1 d=0
>2014-07-16 02:17:32.050+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0
>2014-07-16 02:17:32.050+0000: 4380: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5620000a90
>2014-07-16 02:17:32.050+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0
>2014-07-16 02:17:32.050+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0
>2014-07-16 02:17:32.050+0000: 4380: debug : virNetMessageEncodePayload:374 : Encode length as 36
>2014-07-16 02:17:32.050+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=36, f=26 e=25 d=0
>2014-07-16 02:17:32.050+0000: 4380: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5620000a90
>2014-07-16 02:17:32.050+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=10 w=37, f=23 e=1 d=0
>2014-07-16 02:17:32.050+0000: 4380: debug : virNetServerClientSendMessageLocked:1451 : msg=0x7f5656b34420 proc=66 len=36 offset=0
>2014-07-16 02:17:32.050+0000: 4378: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 1 timers
>2014-07-16 02:17:32.050+0000: 4380: debug : virNetServerClientSendMessageLocked:1459 : RPC_SERVER_CLIENT_MSG_TX_QUEUE: client=0x7f5656b345f0 len=36 prog=536903814 vers=1 proc=66 type=1 status=0 serial=0
>2014-07-16 02:17:32.050+0000: 4378: debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms
>2014-07-16 02:17:32.050+0000: 4378: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=10 timeout=-1
>2014-07-16 02:17:32.050+0000: 4380: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7f5656b35af0 tx=0x7f5656b34420
>2014-07-16 02:17:32.050+0000: 4380: debug : virNetServerClientCalculateHandleMode:188 : mode=3
>2014-07-16 02:17:32.050+0000: 4380: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=37 events=3
>2014-07-16 02:17:32.050+0000: 4380: debug : virEventPollInterruptLocked:714 : Interrupting
>2014-07-16 02:17:32.050+0000: 4380: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5656b2f100
>2014-07-16 02:17:32.050+0000: 4378: debug : virEventPollRunOnce:638 : Poll got 1 event(s)
>2014-07-16 02:17:32.050+0000: 4380: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5656b345f0
>2014-07-16 02:17:32.050+0000: 4378: debug : virEventPollDispatchTimeouts:423 : Dispatch 1
>2014-07-16 02:17:32.050+0000: 4378: debug : virEventPollDispatchHandles:468 : Dispatch 10
>2014-07-16 02:17:32.050+0000: 4378: debug : virEventPollDispatchHandles:482 : i=0 w=1
>2014-07-16 02:17:32.050+0000: 4378: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1
>2014-07-16 02:17:32.050+0000: 4378: debug : virEventPollDispatchHandles:482 : i=1 w=2
>2014-07-16 02:17:32.050+0000: 4378: debug : virEventPollDispatchHandles:482 : i=2 w=3
>2014-07-16 02:17:32.050+0000: 4378: debug : virEventPollDispatchHandles:482 : i=3 w=4
>2014-07-16 02:17:32.050+0000: 4378: debug : virEventPollDispatchHandles:482 : i=4 w=5
>2014-07-16 02:17:32.050+0000: 4378: debug : virEventPollDispatchHandles:482 : i=5 w=6
>2014-07-16 02:17:32.050+0000: 4378: debug : virEventPollDispatchHandles:482 : i=7 w=8
>2014-07-16 02:17:32.050+0000: 4378: debug : virEventPollDispatchHandles:482 : i=8 w=9
>2014-07-16 02:17:32.050+0000: 4378: debug : virEventPollDispatchHandles:482 : i=9 w=36
>2014-07-16 02:17:32.050+0000: 4378: debug : virEventPollDispatchHandles:482 : i=10 w=37
>2014-07-16 02:17:32.050+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 1
>2014-07-16 02:17:32.050+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.050+0000: 4378: debug : virEventRunDefaultImpl:270 : running default event implementation
>2014-07-16 02:17:32.050+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 1
>2014-07-16 02:17:32.050+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.050+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0
>2014-07-16 02:17:32.050+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=14 e=1 d=0
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=13 e=1 d=0
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=36, f=26 e=25 d=0
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=10 w=37, f=23 e=5 d=0
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 1 timers
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=10 timeout=-1
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollRunOnce:638 : Poll got 1 event(s)
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollDispatchTimeouts:423 : Dispatch 1
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollDispatchHandles:468 : Dispatch 10
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollDispatchHandles:482 : i=0 w=1
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollDispatchHandles:482 : i=1 w=2
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollDispatchHandles:482 : i=2 w=3
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollDispatchHandles:482 : i=3 w=4
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollDispatchHandles:482 : i=4 w=5
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollDispatchHandles:482 : i=5 w=6
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollDispatchHandles:482 : i=7 w=8
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollDispatchHandles:482 : i=8 w=9
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollDispatchHandles:482 : i=9 w=36
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollDispatchHandles:482 : i=10 w=37
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=37 events=2
>2014-07-16 02:17:32.051+0000: 4378: debug : virNetMessageFree:72 : msg=0x7f5656b34420 nfds=0 cb=(nil)
>2014-07-16 02:17:32.051+0000: 4378: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7f5656b35af0 tx=(nil)
>2014-07-16 02:17:32.051+0000: 4378: debug : virNetServerClientCalculateHandleMode:188 : mode=1
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=37 events=1
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140008766417024
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 1
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventRunDefaultImpl:270 : running default event implementation
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 1
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=14 e=1 d=0
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=13 e=1 d=0
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=36, f=26 e=25 d=0
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=10 w=37, f=23 e=1 d=0
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 1 timers
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=10 timeout=-1
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollRunOnce:638 : Poll got 1 event(s)
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollDispatchTimeouts:423 : Dispatch 1
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollDispatchHandles:468 : Dispatch 10
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollDispatchHandles:482 : i=0 w=1
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollDispatchHandles:482 : i=1 w=2
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollDispatchHandles:482 : i=2 w=3
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollDispatchHandles:482 : i=3 w=4
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollDispatchHandles:482 : i=4 w=5
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollDispatchHandles:482 : i=5 w=6
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollDispatchHandles:482 : i=7 w=8
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollDispatchHandles:482 : i=8 w=9
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollDispatchHandles:482 : i=9 w=36
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollDispatchHandles:482 : i=10 w=37
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=37 events=1
>2014-07-16 02:17:32.051+0000: 4378: debug : virNetMessageDecodeLength:149 : Got length, now need 32 total (28 more)
>2014-07-16 02:17:32.051+0000: 4378: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7f5656b35af0 tx=(nil)
>2014-07-16 02:17:32.051+0000: 4378: debug : virNetServerClientCalculateHandleMode:188 : mode=1
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=37 events=1
>2014-07-16 02:17:32.051+0000: 4378: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140008766417024
>2014-07-16 02:17:32.052+0000: 4378: debug : virNetServerClientDispatchRead:1202 : RPC_SERVER_CLIENT_MSG_RX: client=0x7f5656b345f0 len=32 prog=536903814 vers=1 proc=60 type=0 status=0 serial=1
>2014-07-16 02:17:32.052+0000: 4378: debug : virKeepAliveCheckMessage:374 : ka=0x7f5656b34b50, client=0x7f5656b345f0, msg=0x7f5656b35af0
>2014-07-16 02:17:32.052+0000: 4378: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5656b345f0
>2014-07-16 02:17:32.052+0000: 4378: debug : virNetServerDispatchNewMessage:214 : server=0x7f5656b24720 client=0x7f5656b345f0 message=0x7f5656b35af0
>2014-07-16 02:17:32.052+0000: 4378: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5656b2f100
>2014-07-16 02:17:32.052+0000: 4378: debug : virNetMessageNew:44 : msg=0x7f5656b34a80 tracked=1
>2014-07-16 02:17:32.052+0000: 4381: debug : virNetServerHandleJob:185 : server=0x7f5656b24720 client=0x7f5656b345f0 message=0x7f5656b35af0 prog=0x7f5656b2f100
>2014-07-16 02:17:32.052+0000: 4378: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7f5656b34a80 tx=(nil)
>2014-07-16 02:17:32.052+0000: 4381: debug : virNetServerProgramDispatch:285 : prog=536903814 ver=1 type=0 status=0 serial=1 proc=60
>2014-07-16 02:17:32.052+0000: 4378: debug : virNetServerClientCalculateHandleMode:188 : mode=1
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=37 events=1
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140008766417024
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 1
>2014-07-16 02:17:32.052+0000: 4381: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5620000a90
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.052+0000: 4381: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5620000a90
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventRunDefaultImpl:270 : running default event implementation
>2014-07-16 02:17:32.052+0000: 4381: debug : remoteDispatchConnectSupportsFeatureHelper:2200 : server=0x7f5656b24720 client=0x7f5656b345f0 msg=0x7f5656b35af0 rerr=0x7f5644773c80 args=0x7f5624001060 ret=0x7f56240010d0
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 1
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.052+0000: 4381: debug : virKeepAliveStart:276 : RPC_KEEPALIVE_START: ka=0x7f5656b34b50 client=0x7f5656b345f0 interval=0 count=0
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=14 e=1 d=0
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=13 e=1 d=0
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=36, f=26 e=25 d=0
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=10 w=37, f=23 e=1 d=0
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 1 timers
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms
>2014-07-16 02:17:32.052+0000: 4381: debug : virEventPollInterruptLocked:714 : Interrupting
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=10 timeout=-1
>2014-07-16 02:17:32.052+0000: 4381: debug : virEventPollAddTimeout:248 : EVENT_POLL_ADD_TIMEOUT: timer=4 frequency=5000 cb=0x7f5654353320 opaque=0x7f5656b34b50 ff=0x7f56542602b0
>2014-07-16 02:17:32.052+0000: 4381: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5656b34b50
>2014-07-16 02:17:32.052+0000: 4381: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5620000a90
>2014-07-16 02:17:32.052+0000: 4381: debug : virNetMessageEncodePayload:374 : Encode length as 32
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollRunOnce:638 : Poll got 1 event(s)
>2014-07-16 02:17:32.052+0000: 4381: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5620000a90
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollDispatchTimeouts:423 : Dispatch 2
>2014-07-16 02:17:32.052+0000: 4381: debug : virNetServerClientSendMessageLocked:1451 : msg=0x7f5656b35af0 proc=60 len=32 offset=0
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollDispatchHandles:468 : Dispatch 10
>2014-07-16 02:17:32.052+0000: 4381: debug : virNetServerClientSendMessageLocked:1459 : RPC_SERVER_CLIENT_MSG_TX_QUEUE: client=0x7f5656b345f0 len=32 prog=536903814 vers=1 proc=60 type=1 status=0 serial=1
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollDispatchHandles:482 : i=0 w=1
>2014-07-16 02:17:32.052+0000: 4381: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7f5656b34a80 tx=0x7f5656b35af0
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1
>2014-07-16 02:17:32.052+0000: 4381: debug : virNetServerClientCalculateHandleMode:188 : mode=3
>2014-07-16 02:17:32.052+0000: 4381: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=37 events=3
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollDispatchHandles:482 : i=1 w=2
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollDispatchHandles:482 : i=2 w=3
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollDispatchHandles:482 : i=3 w=4
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollDispatchHandles:482 : i=4 w=5
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollDispatchHandles:482 : i=5 w=6
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollDispatchHandles:482 : i=7 w=8
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollDispatchHandles:482 : i=8 w=9
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollDispatchHandles:482 : i=9 w=36
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollDispatchHandles:482 : i=10 w=37
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 2
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.052+0000: 4381: debug : virEventPollInterruptLocked:710 : Skip interrupt, 0 140008766417024
>2014-07-16 02:17:32.052+0000: 4381: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5656b2f100
>2014-07-16 02:17:32.052+0000: 4381: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5656b345f0
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventRunDefaultImpl:270 : running default event implementation
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 2
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=14 e=1 d=0
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=13 e=1 d=0
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0
>2014-07-16 02:17:32.052+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=36, f=26 e=25 d=0
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=10 w=37, f=23 e=5 d=0
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 2 timers
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1405477057052
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollCalculateTimeout:353 : Schedule timeout then=1405477057052 now=1405477052053
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollCalculateTimeout:361 : Timeout at 1405477057052 due in 4999 ms
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=10 timeout=4999
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollRunOnce:638 : Poll got 1 event(s)
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollDispatchTimeouts:423 : Dispatch 2
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollDispatchHandles:468 : Dispatch 10
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollDispatchHandles:482 : i=0 w=1
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollDispatchHandles:482 : i=1 w=2
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollDispatchHandles:482 : i=2 w=3
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollDispatchHandles:482 : i=3 w=4
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollDispatchHandles:482 : i=4 w=5
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollDispatchHandles:482 : i=5 w=6
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollDispatchHandles:482 : i=7 w=8
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollDispatchHandles:482 : i=8 w=9
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollDispatchHandles:482 : i=9 w=36
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollDispatchHandles:482 : i=10 w=37
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=37 events=2
>2014-07-16 02:17:32.053+0000: 4378: debug : virNetMessageFree:72 : msg=0x7f5656b35af0 nfds=0 cb=(nil)
>2014-07-16 02:17:32.053+0000: 4378: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7f5656b34a80 tx=(nil)
>2014-07-16 02:17:32.053+0000: 4378: debug : virNetServerClientCalculateHandleMode:188 : mode=1
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=37 events=1
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140008766417024
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 2
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventRunDefaultImpl:270 : running default event implementation
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 2
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=14 e=1 d=0
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=13 e=1 d=0
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=36, f=26 e=25 d=0
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=10 w=37, f=23 e=1 d=0
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 2 timers
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1405477057052
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollCalculateTimeout:353 : Schedule timeout then=1405477057052 now=1405477052053
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollCalculateTimeout:361 : Timeout at 1405477057052 due in 4999 ms
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=10 timeout=4999
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollRunOnce:638 : Poll got 1 event(s)
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollDispatchTimeouts:423 : Dispatch 2
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollDispatchHandles:468 : Dispatch 10
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollDispatchHandles:482 : i=0 w=1
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollDispatchHandles:482 : i=1 w=2
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollDispatchHandles:482 : i=2 w=3
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollDispatchHandles:482 : i=3 w=4
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollDispatchHandles:482 : i=4 w=5
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollDispatchHandles:482 : i=5 w=6
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollDispatchHandles:482 : i=7 w=8
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollDispatchHandles:482 : i=8 w=9
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollDispatchHandles:482 : i=9 w=36
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollDispatchHandles:482 : i=10 w=37
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=37 events=1
>2014-07-16 02:17:32.053+0000: 4378: debug : virNetMessageDecodeLength:149 : Got length, now need 40 total (36 more)
>2014-07-16 02:17:32.053+0000: 4378: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7f5656b34a80 tx=(nil)
>2014-07-16 02:17:32.053+0000: 4378: debug : virNetServerClientCalculateHandleMode:188 : mode=1
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=37 events=1
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140008766417024
>2014-07-16 02:17:32.053+0000: 4378: debug : virNetServerClientDispatchRead:1202 : RPC_SERVER_CLIENT_MSG_RX: client=0x7f5656b345f0 len=40 prog=536903814 vers=1 proc=1 type=0 status=0 serial=2
>2014-07-16 02:17:32.053+0000: 4378: debug : virKeepAliveCheckMessage:374 : ka=0x7f5656b34b50, client=0x7f5656b345f0, msg=0x7f5656b34a80
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollUpdateTimeout:260 : EVENT_POLL_UPDATE_TIMEOUT: timer=4 frequency=5000
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollUpdateTimeout:278 : Set timer freq=5000 expires=1405477057053
>2014-07-16 02:17:32.053+0000: 4378: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140008766417024
>2014-07-16 02:17:32.054+0000: 4378: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5656b345f0
>2014-07-16 02:17:32.054+0000: 4378: debug : virNetServerDispatchNewMessage:214 : server=0x7f5656b24720 client=0x7f5656b345f0 message=0x7f5656b34a80
>2014-07-16 02:17:32.054+0000: 4378: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5656b2f100
>2014-07-16 02:17:32.054+0000: 4378: debug : virNetMessageNew:44 : msg=0x7f5656b343b0 tracked=1
>2014-07-16 02:17:32.054+0000: 4382: debug : virNetServerHandleJob:185 : server=0x7f5656b24720 client=0x7f5656b345f0 message=0x7f5656b34a80 prog=0x7f5656b2f100
>2014-07-16 02:17:32.054+0000: 4378: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7f5656b343b0 tx=(nil)
>2014-07-16 02:17:32.054+0000: 4382: debug : virNetServerProgramDispatch:285 : prog=536903814 ver=1 type=0 status=0 serial=2 proc=1
>2014-07-16 02:17:32.054+0000: 4378: debug : virNetServerClientCalculateHandleMode:188 : mode=1
>2014-07-16 02:17:32.054+0000: 4378: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=37 events=1
>2014-07-16 02:17:32.054+0000: 4378: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140008766417024
>2014-07-16 02:17:32.054+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 2
>2014-07-16 02:17:32.054+0000: 4382: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5620000a90
>2014-07-16 02:17:32.054+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.054+0000: 4382: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5620000a90
>2014-07-16 02:17:32.054+0000: 4378: debug : virEventRunDefaultImpl:270 : running default event implementation
>2014-07-16 02:17:32.054+0000: 4382: debug : remoteDispatchConnectOpenHelper:2178 : server=0x7f5656b24720 client=0x7f5656b345f0 msg=0x7f5656b34a80 rerr=0x7f5643f72c80 args=0x7f5618000c80 ret=0x7f5618000ca0
>2014-07-16 02:17:32.054+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 2
>2014-07-16 02:17:32.054+0000: 4382: debug : remoteDispatchConnectOpen:785 : priv=0x7f5656b347c0 conn=(nil)
>2014-07-16 02:17:32.054+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.054+0000: 4382: debug : virConnectOpen:1405 : name=
>2014-07-16 02:17:32.054+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0
>2014-07-16 02:17:32.054+0000: 4382: debug : virObjectNew:199 : OBJECT_NEW: obj=0x7f5618000a70 classname=virConnect
>2014-07-16 02:17:32.054+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0
>2014-07-16 02:17:32.054+0000: 4382: debug : virObjectNew:199 : OBJECT_NEW: obj=0x7f5618000ba0 classname=virConnectCloseCallbackData
>2014-07-16 02:17:32.054+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0
>2014-07-16 02:17:32.054+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0
>2014-07-16 02:17:32.054+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=14 e=1 d=0
>2014-07-16 02:17:32.054+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=13 e=1 d=0
>2014-07-16 02:17:32.054+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0
>2014-07-16 02:17:32.054+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0
>2014-07-16 02:17:32.054+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0
>2014-07-16 02:17:32.054+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=36, f=26 e=25 d=0
>2014-07-16 02:17:32.054+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=10 w=37, f=23 e=1 d=0
>2014-07-16 02:17:32.054+0000: 4378: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 2 timers
>2014-07-16 02:17:32.054+0000: 4378: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1405477057053
>2014-07-16 02:17:32.054+0000: 4382: debug : virConnectGetConfigFile:1014 : Loading config file '/etc/libvirt/libvirt.conf'
>2014-07-16 02:17:32.054+0000: 4378: debug : virEventPollCalculateTimeout:353 : Schedule timeout then=1405477057053 now=1405477052054
>2014-07-16 02:17:32.054+0000: 4382: debug : virConfReadFile:745 : filename=/etc/libvirt/libvirt.conf
>2014-07-16 02:17:32.054+0000: 4378: debug : virEventPollCalculateTimeout:361 : Timeout at 1405477057053 due in 4999 ms
>2014-07-16 02:17:32.054+0000: 4378: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=10 timeout=4999
>2014-07-16 02:17:32.054+0000: 4382: debug : virFileClose:90 : Closed fd 24
>2014-07-16 02:17:32.054+0000: 4382: debug : do_open:1195 : no name, allowing driver auto-select
>2014-07-16 02:17:32.054+0000: 4382: debug : do_open:1237 : trying driver 0 (Test) ...
>2014-07-16 02:17:32.054+0000: 4382: debug : do_open:1244 : driver 0 Test returned DECLINED
>2014-07-16 02:17:32.054+0000: 4382: debug : do_open:1237 : trying driver 1 (ESX) ...
>2014-07-16 02:17:32.054+0000: 4382: debug : do_open:1244 : driver 1 ESX returned DECLINED
>2014-07-16 02:17:32.054+0000: 4382: debug : do_open:1237 : trying driver 2 (remote) ...
>2014-07-16 02:17:32.054+0000: 4382: debug : do_open:1244 : driver 2 remote returned DECLINED
>2014-07-16 02:17:32.054+0000: 4382: debug : do_open:1237 : trying driver 3 (QEMU) ...
>2014-07-16 02:17:32.054+0000: 4382: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5634152910
>2014-07-16 02:17:32.054+0000: 4382: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5656b2fbc0
>2014-07-16 02:17:32.054+0000: 4382: debug : virAccessManagerCheckConnect:215 : manager=0x7f5656b2fbc0(name=stack) driver=QEMU perm=0
>2014-07-16 02:17:32.054+0000: 4382: debug : virAccessManagerCheckConnect:215 : manager=0x7f5656b242c0(name=none) driver=QEMU perm=0
>2014-07-16 02:17:32.054+0000: 4382: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5656b2fbc0
>2014-07-16 02:17:32.054+0000: 4382: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5634152910
>2014-07-16 02:17:32.054+0000: 4382: debug : do_open:1244 : driver 3 QEMU returned SUCCESS
>2014-07-16 02:17:32.054+0000: 4382: debug : do_open:1270 : network driver 0 Test returned DECLINED
>2014-07-16 02:17:32.054+0000: 4382: debug : do_open:1270 : network driver 1 ESX returned DECLINED
>2014-07-16 02:17:32.054+0000: 4382: debug : do_open:1270 : network driver 2 remote returned DECLINED
>2014-07-16 02:17:32.054+0000: 4382: debug : do_open:1270 : network driver 3 Network returned SUCCESS
>2014-07-16 02:17:32.054+0000: 4382: debug : do_open:1286 : interface driver 0 Test returned DECLINED
>2014-07-16 02:17:32.054+0000: 4382: debug : do_open:1286 : interface driver 1 ESX returned DECLINED
>2014-07-16 02:17:32.054+0000: 4382: debug : do_open:1286 : interface driver 2 remote returned DECLINED
>2014-07-16 02:17:32.054+0000: 4382: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f56340109b0
>2014-07-16 02:17:32.054+0000: 4382: debug : do_open:1286 : interface driver 3 netcf returned SUCCESS
>2014-07-16 02:17:32.054+0000: 4382: debug : do_open:1303 : storage driver 0 Test returned DECLINED
>2014-07-16 02:17:32.054+0000: 4382: debug : do_open:1303 : storage driver 1 ESX returned DECLINED
>2014-07-16 02:17:32.054+0000: 4382: debug : do_open:1303 : storage driver 2 remote returned DECLINED
>2014-07-16 02:17:32.054+0000: 4382: debug : do_open:1303 : storage driver 3 storage returned SUCCESS
>2014-07-16 02:17:32.054+0000: 4382: debug : do_open:1320 : node driver 0 Test returned DECLINED
>2014-07-16 02:17:32.054+0000: 4382: debug : do_open:1320 : node driver 1 ESX returned DECLINED
>2014-07-16 02:17:32.054+0000: 4382: debug : do_open:1320 : node driver 2 remote returned DECLINED
>2014-07-16 02:17:32.054+0000: 4382: debug : do_open:1320 : node driver 3 udevNodeDeviceDriver returned SUCCESS
>2014-07-16 02:17:32.054+0000: 4382: debug : do_open:1337 : secret driver 0 Test returned DECLINED
>2014-07-16 02:17:32.054+0000: 4382: debug : do_open:1337 : secret driver 1 ESX returned DECLINED
>2014-07-16 02:17:32.054+0000: 4382: debug : do_open:1337 : secret driver 2 remote returned DECLINED
>2014-07-16 02:17:32.054+0000: 4382: debug : do_open:1337 : secret driver 3 secret returned SUCCESS
>2014-07-16 02:17:32.054+0000: 4382: debug : do_open:1354 : nwfilter driver 0 Test returned DECLINED
>2014-07-16 02:17:32.054+0000: 4382: debug : do_open:1354 : nwfilter driver 1 ESX returned DECLINED
>2014-07-16 02:17:32.054+0000: 4382: debug : do_open:1354 : nwfilter driver 2 remote returned DECLINED
>2014-07-16 02:17:32.054+0000: 4382: debug : do_open:1354 : nwfilter driver 3 nwfilter returned SUCCESS
>2014-07-16 02:17:32.054+0000: 4382: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5620000a90
>2014-07-16 02:17:32.054+0000: 4382: debug : virNetMessageEncodePayload:374 : Encode length as 28
>2014-07-16 02:17:32.054+0000: 4382: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5620000a90
>2014-07-16 02:17:32.054+0000: 4382: debug : virNetServerClientSendMessageLocked:1451 : msg=0x7f5656b34a80 proc=1 len=28 offset=0
>2014-07-16 02:17:32.054+0000: 4382: debug : virNetServerClientSendMessageLocked:1459 : RPC_SERVER_CLIENT_MSG_TX_QUEUE: client=0x7f5656b345f0 len=28 prog=536903814 vers=1 proc=1 type=1 status=0 serial=2
>2014-07-16 02:17:32.054+0000: 4382: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7f5656b343b0 tx=0x7f5656b34a80
>2014-07-16 02:17:32.054+0000: 4382: debug : virNetServerClientCalculateHandleMode:188 : mode=3
>2014-07-16 02:17:32.054+0000: 4382: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=37 events=3
>2014-07-16 02:17:32.054+0000: 4382: debug : virEventPollInterruptLocked:714 : Interrupting
>2014-07-16 02:17:32.054+0000: 4382: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5656b2f100
>2014-07-16 02:17:32.054+0000: 4382: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5656b345f0
>2014-07-16 02:17:32.054+0000: 4378: debug : virEventPollRunOnce:638 : Poll got 1 event(s)
>2014-07-16 02:17:32.054+0000: 4378: debug : virEventPollDispatchTimeouts:423 : Dispatch 2
>2014-07-16 02:17:32.054+0000: 4378: debug : virEventPollDispatchHandles:468 : Dispatch 10
>2014-07-16 02:17:32.054+0000: 4378: debug : virEventPollDispatchHandles:482 : i=0 w=1
>2014-07-16 02:17:32.054+0000: 4378: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1
>2014-07-16 02:17:32.054+0000: 4378: debug : virEventPollDispatchHandles:482 : i=1 w=2
>2014-07-16 02:17:32.054+0000: 4378: debug : virEventPollDispatchHandles:482 : i=2 w=3
>2014-07-16 02:17:32.054+0000: 4378: debug : virEventPollDispatchHandles:482 : i=3 w=4
>2014-07-16 02:17:32.054+0000: 4378: debug : virEventPollDispatchHandles:482 : i=4 w=5
>2014-07-16 02:17:32.054+0000: 4378: debug : virEventPollDispatchHandles:482 : i=5 w=6
>2014-07-16 02:17:32.054+0000: 4378: debug : virEventPollDispatchHandles:482 : i=7 w=8
>2014-07-16 02:17:32.054+0000: 4378: debug : virEventPollDispatchHandles:482 : i=8 w=9
>2014-07-16 02:17:32.054+0000: 4378: debug : virEventPollDispatchHandles:482 : i=9 w=36
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollDispatchHandles:482 : i=10 w=37
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 2
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventRunDefaultImpl:270 : running default event implementation
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 2
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=14 e=1 d=0
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=13 e=1 d=0
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=36, f=26 e=25 d=0
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=10 w=37, f=23 e=5 d=0
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 2 timers
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1405477057053
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollCalculateTimeout:353 : Schedule timeout then=1405477057053 now=1405477052055
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollCalculateTimeout:361 : Timeout at 1405477057053 due in 4998 ms
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=10 timeout=4998
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollRunOnce:638 : Poll got 1 event(s)
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollDispatchTimeouts:423 : Dispatch 2
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollDispatchHandles:468 : Dispatch 10
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollDispatchHandles:482 : i=0 w=1
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollDispatchHandles:482 : i=1 w=2
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollDispatchHandles:482 : i=2 w=3
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollDispatchHandles:482 : i=3 w=4
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollDispatchHandles:482 : i=4 w=5
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollDispatchHandles:482 : i=5 w=6
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollDispatchHandles:482 : i=7 w=8
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollDispatchHandles:482 : i=8 w=9
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollDispatchHandles:482 : i=9 w=36
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollDispatchHandles:482 : i=10 w=37
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=37 events=2
>2014-07-16 02:17:32.055+0000: 4378: debug : virNetMessageFree:72 : msg=0x7f5656b34a80 nfds=0 cb=(nil)
>2014-07-16 02:17:32.055+0000: 4378: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7f5656b343b0 tx=(nil)
>2014-07-16 02:17:32.055+0000: 4378: debug : virNetServerClientCalculateHandleMode:188 : mode=1
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=37 events=1
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140008766417024
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 2
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventRunDefaultImpl:270 : running default event implementation
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 2
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=14 e=1 d=0
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=13 e=1 d=0
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=36, f=26 e=25 d=0
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=10 w=37, f=23 e=1 d=0
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 2 timers
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1405477057053
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollCalculateTimeout:353 : Schedule timeout then=1405477057053 now=1405477052055
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollCalculateTimeout:361 : Timeout at 1405477057053 due in 4998 ms
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=10 timeout=4998
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollRunOnce:638 : Poll got 1 event(s)
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollDispatchTimeouts:423 : Dispatch 2
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollDispatchHandles:468 : Dispatch 10
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollDispatchHandles:482 : i=0 w=1
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollDispatchHandles:482 : i=1 w=2
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollDispatchHandles:482 : i=2 w=3
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollDispatchHandles:482 : i=3 w=4
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollDispatchHandles:482 : i=4 w=5
>2014-07-16 02:17:32.055+0000: 4378: debug : virEventPollDispatchHandles:482 : i=5 w=6
>2014-07-16 02:17:32.056+0000: 4378: debug : virEventPollDispatchHandles:482 : i=7 w=8
>2014-07-16 02:17:32.056+0000: 4378: debug : virEventPollDispatchHandles:482 : i=8 w=9
>2014-07-16 02:17:32.056+0000: 4378: debug : virEventPollDispatchHandles:482 : i=9 w=36
>2014-07-16 02:17:32.056+0000: 4378: debug : virEventPollDispatchHandles:482 : i=10 w=37
>2014-07-16 02:17:32.056+0000: 4378: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=37 events=1
>2014-07-16 02:17:32.056+0000: 4378: debug : virNetMessageDecodeLength:149 : Got length, now need 28 total (24 more)
>2014-07-16 02:17:32.056+0000: 4378: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7f5656b343b0 tx=(nil)
>2014-07-16 02:17:32.056+0000: 4378: debug : virNetServerClientCalculateHandleMode:188 : mode=1
>2014-07-16 02:17:32.056+0000: 4378: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=37 events=1
>2014-07-16 02:17:32.056+0000: 4378: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140008766417024
>2014-07-16 02:17:32.056+0000: 4378: debug : virNetServerClientDispatchRead:1202 : RPC_SERVER_CLIENT_MSG_RX: client=0x7f5656b345f0 len=28 prog=536903814 vers=1 proc=110 type=0 status=0 serial=3
>2014-07-16 02:17:32.056+0000: 4378: debug : virKeepAliveCheckMessage:374 : ka=0x7f5656b34b50, client=0x7f5656b345f0, msg=0x7f5656b343b0
>2014-07-16 02:17:32.056+0000: 4378: debug : virEventPollUpdateTimeout:260 : EVENT_POLL_UPDATE_TIMEOUT: timer=4 frequency=5000
>2014-07-16 02:17:32.056+0000: 4378: debug : virEventPollUpdateTimeout:278 : Set timer freq=5000 expires=1405477057056
>2014-07-16 02:17:32.056+0000: 4378: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140008766417024
>2014-07-16 02:17:32.056+0000: 4378: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5656b345f0
>2014-07-16 02:17:32.056+0000: 4378: debug : virNetServerDispatchNewMessage:214 : server=0x7f5656b24720 client=0x7f5656b345f0 message=0x7f5656b343b0
>2014-07-16 02:17:32.056+0000: 4378: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5656b2f100
>2014-07-16 02:17:32.056+0000: 4378: debug : virNetMessageNew:44 : msg=0x7f5656b35670 tracked=1
>2014-07-16 02:17:32.056+0000: 4378: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7f5656b35670 tx=(nil)
>2014-07-16 02:17:32.056+0000: 4378: debug : virNetServerClientCalculateHandleMode:188 : mode=1
>2014-07-16 02:17:32.056+0000: 4378: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=37 events=1
>2014-07-16 02:17:32.056+0000: 4383: debug : virNetServerHandleJob:185 : server=0x7f5656b24720 client=0x7f5656b345f0 message=0x7f5656b343b0 prog=0x7f5656b2f100
>2014-07-16 02:17:32.056+0000: 4378: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140008766417024
>2014-07-16 02:17:32.056+0000: 4383: debug : virNetServerProgramDispatch:285 : prog=536903814 ver=1 type=0 status=0 serial=3 proc=110
>2014-07-16 02:17:32.056+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 2
>2014-07-16 02:17:32.056+0000: 4383: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5620000a90
>2014-07-16 02:17:32.056+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.056+0000: 4383: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5620000a90
>2014-07-16 02:17:32.056+0000: 4378: debug : virEventRunDefaultImpl:270 : running default event implementation
>2014-07-16 02:17:32.056+0000: 4383: debug : remoteDispatchConnectGetURIHelper:780 : server=0x7f5656b24720 client=0x7f5656b345f0 msg=0x7f5656b343b0 rerr=0x7f5643771c80 args=0x7f561c00b8d0 ret=0x7f561c0084d0
>2014-07-16 02:17:32.056+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 2
>2014-07-16 02:17:32.056+0000: 4383: debug : virConnectGetURI:1774 : conn=0x7f5618000a70
>2014-07-16 02:17:32.056+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.056+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0
>2014-07-16 02:17:32.056+0000: 4383: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5620000a90
>2014-07-16 02:17:32.056+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0
>2014-07-16 02:17:32.056+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0
>2014-07-16 02:17:32.056+0000: 4383: debug : virNetMessageEncodePayload:374 : Encode length as 48
>2014-07-16 02:17:32.056+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0
>2014-07-16 02:17:32.056+0000: 4383: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5620000a90
>2014-07-16 02:17:32.056+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=14 e=1 d=0
>2014-07-16 02:17:32.056+0000: 4383: debug : virNetServerClientSendMessageLocked:1451 : msg=0x7f5656b343b0 proc=110 len=48 offset=0
>2014-07-16 02:17:32.056+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=13 e=1 d=0
>2014-07-16 02:17:32.056+0000: 4383: debug : virNetServerClientSendMessageLocked:1459 : RPC_SERVER_CLIENT_MSG_TX_QUEUE: client=0x7f5656b345f0 len=48 prog=536903814 vers=1 proc=110 type=1 status=0 serial=3
>2014-07-16 02:17:32.056+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0
>2014-07-16 02:17:32.056+0000: 4383: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7f5656b35670 tx=0x7f5656b343b0
>2014-07-16 02:17:32.056+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0
>2014-07-16 02:17:32.056+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0
>2014-07-16 02:17:32.056+0000: 4383: debug : virNetServerClientCalculateHandleMode:188 : mode=3
>2014-07-16 02:17:32.056+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=36, f=26 e=25 d=0
>2014-07-16 02:17:32.056+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=10 w=37, f=23 e=1 d=0
>2014-07-16 02:17:32.056+0000: 4383: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=37 events=3
>2014-07-16 02:17:32.056+0000: 4378: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 2 timers
>2014-07-16 02:17:32.056+0000: 4378: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1405477057056
>2014-07-16 02:17:32.056+0000: 4378: debug : virEventPollCalculateTimeout:353 : Schedule timeout then=1405477057056 now=1405477052056
>2014-07-16 02:17:32.056+0000: 4378: debug : virEventPollCalculateTimeout:361 : Timeout at 1405477057056 due in 5000 ms
>2014-07-16 02:17:32.056+0000: 4378: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=10 timeout=5000
>2014-07-16 02:17:32.056+0000: 4383: debug : virEventPollInterruptLocked:714 : Interrupting
>2014-07-16 02:17:32.056+0000: 4383: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5656b2f100
>2014-07-16 02:17:32.056+0000: 4378: debug : virEventPollRunOnce:638 : Poll got 1 event(s)
>2014-07-16 02:17:32.056+0000: 4383: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5656b345f0
>2014-07-16 02:17:32.056+0000: 4378: debug : virEventPollDispatchTimeouts:423 : Dispatch 2
>2014-07-16 02:17:32.056+0000: 4378: debug : virEventPollDispatchHandles:468 : Dispatch 10
>2014-07-16 02:17:32.056+0000: 4378: debug : virEventPollDispatchHandles:482 : i=0 w=1
>2014-07-16 02:17:32.056+0000: 4378: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1
>2014-07-16 02:17:32.056+0000: 4378: debug : virEventPollDispatchHandles:482 : i=1 w=2
>2014-07-16 02:17:32.056+0000: 4378: debug : virEventPollDispatchHandles:482 : i=2 w=3
>2014-07-16 02:17:32.056+0000: 4378: debug : virEventPollDispatchHandles:482 : i=3 w=4
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollDispatchHandles:482 : i=4 w=5
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollDispatchHandles:482 : i=5 w=6
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollDispatchHandles:482 : i=7 w=8
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollDispatchHandles:482 : i=8 w=9
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollDispatchHandles:482 : i=9 w=36
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollDispatchHandles:482 : i=10 w=37
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 2
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventRunDefaultImpl:270 : running default event implementation
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 2
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=14 e=1 d=0
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=13 e=1 d=0
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=36, f=26 e=25 d=0
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=10 w=37, f=23 e=5 d=0
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 2 timers
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1405477057056
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollCalculateTimeout:353 : Schedule timeout then=1405477057056 now=1405477052057
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollCalculateTimeout:361 : Timeout at 1405477057056 due in 4999 ms
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=10 timeout=4999
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollRunOnce:638 : Poll got 1 event(s)
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollDispatchTimeouts:423 : Dispatch 2
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollDispatchHandles:468 : Dispatch 10
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollDispatchHandles:482 : i=0 w=1
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollDispatchHandles:482 : i=1 w=2
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollDispatchHandles:482 : i=2 w=3
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollDispatchHandles:482 : i=3 w=4
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollDispatchHandles:482 : i=4 w=5
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollDispatchHandles:482 : i=5 w=6
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollDispatchHandles:482 : i=7 w=8
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollDispatchHandles:482 : i=8 w=9
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollDispatchHandles:482 : i=9 w=36
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollDispatchHandles:482 : i=10 w=37
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=37 events=2
>2014-07-16 02:17:32.057+0000: 4378: debug : virNetMessageFree:72 : msg=0x7f5656b343b0 nfds=0 cb=(nil)
>2014-07-16 02:17:32.057+0000: 4378: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7f5656b35670 tx=(nil)
>2014-07-16 02:17:32.057+0000: 4378: debug : virNetServerClientCalculateHandleMode:188 : mode=1
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=37 events=1
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140008766417024
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 2
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventRunDefaultImpl:270 : running default event implementation
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 2
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=14 e=1 d=0
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=13 e=1 d=0
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=36, f=26 e=25 d=0
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=10 w=37, f=23 e=1 d=0
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 2 timers
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1405477057056
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollCalculateTimeout:353 : Schedule timeout then=1405477057056 now=1405477052057
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollCalculateTimeout:361 : Timeout at 1405477057056 due in 4999 ms
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=10 timeout=4999
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollRunOnce:638 : Poll got 1 event(s)
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollDispatchTimeouts:423 : Dispatch 2
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollDispatchHandles:468 : Dispatch 10
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollDispatchHandles:482 : i=0 w=1
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollDispatchHandles:482 : i=1 w=2
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollDispatchHandles:482 : i=2 w=3
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollDispatchHandles:482 : i=3 w=4
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollDispatchHandles:482 : i=4 w=5
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollDispatchHandles:482 : i=5 w=6
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollDispatchHandles:482 : i=7 w=8
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollDispatchHandles:482 : i=8 w=9
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollDispatchHandles:482 : i=9 w=36
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollDispatchHandles:482 : i=10 w=37
>2014-07-16 02:17:32.057+0000: 4378: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=37 events=1
>2014-07-16 02:17:32.057+0000: 4378: debug : virNetMessageDecodeLength:149 : Got length, now need 36 total (32 more)
>2014-07-16 02:17:32.058+0000: 4378: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7f5656b35670 tx=(nil)
>2014-07-16 02:17:32.058+0000: 4378: debug : virNetServerClientCalculateHandleMode:188 : mode=1
>2014-07-16 02:17:32.058+0000: 4378: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=37 events=1
>2014-07-16 02:17:32.058+0000: 4378: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140008766417024
>2014-07-16 02:17:32.058+0000: 4378: debug : virNetServerClientDispatchRead:1202 : RPC_SERVER_CLIENT_MSG_RX: client=0x7f5656b345f0 len=36 prog=536903814 vers=1 proc=23 type=0 status=0 serial=4
>2014-07-16 02:17:32.058+0000: 4378: debug : virKeepAliveCheckMessage:374 : ka=0x7f5656b34b50, client=0x7f5656b345f0, msg=0x7f5656b35670
>2014-07-16 02:17:32.058+0000: 4378: debug : virEventPollUpdateTimeout:260 : EVENT_POLL_UPDATE_TIMEOUT: timer=4 frequency=5000
>2014-07-16 02:17:32.058+0000: 4378: debug : virEventPollUpdateTimeout:278 : Set timer freq=5000 expires=1405477057058
>2014-07-16 02:17:32.058+0000: 4378: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140008766417024
>2014-07-16 02:17:32.058+0000: 4378: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5656b345f0
>2014-07-16 02:17:32.058+0000: 4378: debug : virNetServerDispatchNewMessage:214 : server=0x7f5656b24720 client=0x7f5656b345f0 message=0x7f5656b35670
>2014-07-16 02:17:32.058+0000: 4378: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5656b2f100
>2014-07-16 02:17:32.058+0000: 4378: debug : virNetMessageNew:44 : msg=0x7f5656b34a10 tracked=1
>2014-07-16 02:17:32.058+0000: 4379: debug : virNetServerHandleJob:185 : server=0x7f5656b24720 client=0x7f5656b345f0 message=0x7f5656b35670 prog=0x7f5656b2f100
>2014-07-16 02:17:32.058+0000: 4378: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7f5656b34a10 tx=(nil)
>2014-07-16 02:17:32.058+0000: 4379: debug : virNetServerProgramDispatch:285 : prog=536903814 ver=1 type=0 status=0 serial=4 proc=23
>2014-07-16 02:17:32.058+0000: 4378: debug : virNetServerClientCalculateHandleMode:188 : mode=1
>2014-07-16 02:17:32.058+0000: 4378: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=37 events=1
>2014-07-16 02:17:32.058+0000: 4378: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140008766417024
>2014-07-16 02:17:32.058+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 2
>2014-07-16 02:17:32.058+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.058+0000: 4379: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5620000a90
>2014-07-16 02:17:32.058+0000: 4379: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5620000a90
>2014-07-16 02:17:32.058+0000: 4378: debug : virEventRunDefaultImpl:270 : running default event implementation
>2014-07-16 02:17:32.058+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 2
>2014-07-16 02:17:32.058+0000: 4379: debug : remoteDispatchDomainLookupByNameHelper:4943 : server=0x7f5656b24720 client=0x7f5656b345f0 msg=0x7f5656b35670 rerr=0x7f5645775c80 args=0x7f563400aa20 ret=0x7f56342a3da0
>2014-07-16 02:17:32.058+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.058+0000: 4379: debug : virDomainLookupByName:2264 : conn=0x7f5618000a70, name=test
>2014-07-16 02:17:32.058+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0
>2014-07-16 02:17:32.058+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0
>2014-07-16 02:17:32.058+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0
>2014-07-16 02:17:32.058+0000: 4379: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5656b2fbc0
>2014-07-16 02:17:32.058+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0
>2014-07-16 02:17:32.058+0000: 4379: debug : virAccessManagerCheckDomain:231 : manager=0x7f5656b2fbc0(name=stack) driver=QEMU domain=0x7f561c00db40 perm=0
>2014-07-16 02:17:32.058+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=14 e=1 d=0
>2014-07-16 02:17:32.058+0000: 4379: debug : virAccessManagerCheckDomain:231 : manager=0x7f5656b242c0(name=none) driver=QEMU domain=0x7f561c00db40 perm=0
>2014-07-16 02:17:32.058+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=13 e=1 d=0
>2014-07-16 02:17:32.058+0000: 4379: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5656b2fbc0
>2014-07-16 02:17:32.058+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0
>2014-07-16 02:17:32.058+0000: 4379: debug : virObjectNew:199 : OBJECT_NEW: obj=0x7f56342a3d60 classname=virDomain
>2014-07-16 02:17:32.058+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0
>2014-07-16 02:17:32.058+0000: 4379: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5618000a70
>2014-07-16 02:17:32.058+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0
>2014-07-16 02:17:32.058+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=36, f=26 e=25 d=0
>2014-07-16 02:17:32.058+0000: 4379: debug : virDomainFree:2428 : dom=0x7f56342a3d60, (VM: name=test, uuid=fcbf1ce6-8f62-4ccd-8d0f-b6a0f612f2db)
>2014-07-16 02:17:32.058+0000: 4379: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f56342a3d60
>2014-07-16 02:17:32.058+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=10 w=37, f=23 e=1 d=0
>2014-07-16 02:17:32.058+0000: 4379: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f56342a3d60
>2014-07-16 02:17:32.058+0000: 4378: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 2 timers
>2014-07-16 02:17:32.058+0000: 4378: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1405477057058
>2014-07-16 02:17:32.058+0000: 4379: debug : virDomainDispose:262 : release domain 0x7f56342a3d60 test fcbf1ce6-8f62-4ccd-8d0f-b6a0f612f2db
>2014-07-16 02:17:32.058+0000: 4378: debug : virEventPollCalculateTimeout:353 : Schedule timeout then=1405477057058 now=1405477052058
>2014-07-16 02:17:32.058+0000: 4379: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5618000a70
>2014-07-16 02:17:32.058+0000: 4378: debug : virEventPollCalculateTimeout:361 : Timeout at 1405477057058 due in 5000 ms
>2014-07-16 02:17:32.058+0000: 4378: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=10 timeout=5000
>2014-07-16 02:17:32.058+0000: 4379: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5620000a90
>2014-07-16 02:17:32.058+0000: 4379: debug : virNetMessageEncodePayload:374 : Encode length as 56
>2014-07-16 02:17:32.058+0000: 4379: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5620000a90
>2014-07-16 02:17:32.058+0000: 4379: debug : virNetServerClientSendMessageLocked:1451 : msg=0x7f5656b35670 proc=23 len=56 offset=0
>2014-07-16 02:17:32.058+0000: 4379: debug : virNetServerClientSendMessageLocked:1459 : RPC_SERVER_CLIENT_MSG_TX_QUEUE: client=0x7f5656b345f0 len=56 prog=536903814 vers=1 proc=23 type=1 status=0 serial=4
>2014-07-16 02:17:32.058+0000: 4379: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7f5656b34a10 tx=0x7f5656b35670
>2014-07-16 02:17:32.058+0000: 4379: debug : virNetServerClientCalculateHandleMode:188 : mode=3
>2014-07-16 02:17:32.058+0000: 4379: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=37 events=3
>2014-07-16 02:17:32.058+0000: 4379: debug : virEventPollInterruptLocked:714 : Interrupting
>2014-07-16 02:17:32.058+0000: 4379: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5656b2f100
>2014-07-16 02:17:32.058+0000: 4379: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5656b345f0
>2014-07-16 02:17:32.058+0000: 4378: debug : virEventPollRunOnce:638 : Poll got 1 event(s)
>2014-07-16 02:17:32.058+0000: 4378: debug : virEventPollDispatchTimeouts:423 : Dispatch 2
>2014-07-16 02:17:32.058+0000: 4378: debug : virEventPollDispatchHandles:468 : Dispatch 10
>2014-07-16 02:17:32.058+0000: 4378: debug : virEventPollDispatchHandles:482 : i=0 w=1
>2014-07-16 02:17:32.058+0000: 4378: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1
>2014-07-16 02:17:32.058+0000: 4378: debug : virEventPollDispatchHandles:482 : i=1 w=2
>2014-07-16 02:17:32.058+0000: 4378: debug : virEventPollDispatchHandles:482 : i=2 w=3
>2014-07-16 02:17:32.058+0000: 4378: debug : virEventPollDispatchHandles:482 : i=3 w=4
>2014-07-16 02:17:32.058+0000: 4378: debug : virEventPollDispatchHandles:482 : i=4 w=5
>2014-07-16 02:17:32.058+0000: 4378: debug : virEventPollDispatchHandles:482 : i=5 w=6
>2014-07-16 02:17:32.058+0000: 4378: debug : virEventPollDispatchHandles:482 : i=7 w=8
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollDispatchHandles:482 : i=8 w=9
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollDispatchHandles:482 : i=9 w=36
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollDispatchHandles:482 : i=10 w=37
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 2
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventRunDefaultImpl:270 : running default event implementation
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 2
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=14 e=1 d=0
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=13 e=1 d=0
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=36, f=26 e=25 d=0
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=10 w=37, f=23 e=5 d=0
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 2 timers
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1405477057058
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollCalculateTimeout:353 : Schedule timeout then=1405477057058 now=1405477052059
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollCalculateTimeout:361 : Timeout at 1405477057058 due in 4999 ms
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=10 timeout=4999
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollRunOnce:638 : Poll got 1 event(s)
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollDispatchTimeouts:423 : Dispatch 2
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollDispatchHandles:468 : Dispatch 10
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollDispatchHandles:482 : i=0 w=1
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollDispatchHandles:482 : i=1 w=2
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollDispatchHandles:482 : i=2 w=3
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollDispatchHandles:482 : i=3 w=4
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollDispatchHandles:482 : i=4 w=5
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollDispatchHandles:482 : i=5 w=6
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollDispatchHandles:482 : i=7 w=8
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollDispatchHandles:482 : i=8 w=9
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollDispatchHandles:482 : i=9 w=36
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollDispatchHandles:482 : i=10 w=37
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=37 events=2
>2014-07-16 02:17:32.059+0000: 4378: debug : virNetMessageFree:72 : msg=0x7f5656b35670 nfds=0 cb=(nil)
>2014-07-16 02:17:32.059+0000: 4378: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7f5656b34a10 tx=(nil)
>2014-07-16 02:17:32.059+0000: 4378: debug : virNetServerClientCalculateHandleMode:188 : mode=1
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=37 events=1
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140008766417024
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 2
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventRunDefaultImpl:270 : running default event implementation
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 2
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=14 e=1 d=0
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=13 e=1 d=0
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=36, f=26 e=25 d=0
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=10 w=37, f=23 e=1 d=0
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 2 timers
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1405477057058
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollCalculateTimeout:353 : Schedule timeout then=1405477057058 now=1405477052059
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollCalculateTimeout:361 : Timeout at 1405477057058 due in 4999 ms
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=10 timeout=4999
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollRunOnce:638 : Poll got 1 event(s)
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollDispatchTimeouts:423 : Dispatch 2
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollDispatchHandles:468 : Dispatch 10
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollDispatchHandles:482 : i=0 w=1
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollDispatchHandles:482 : i=1 w=2
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollDispatchHandles:482 : i=2 w=3
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollDispatchHandles:482 : i=3 w=4
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollDispatchHandles:482 : i=4 w=5
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollDispatchHandles:482 : i=5 w=6
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollDispatchHandles:482 : i=7 w=8
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollDispatchHandles:482 : i=8 w=9
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollDispatchHandles:482 : i=9 w=36
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollDispatchHandles:482 : i=10 w=37
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=37 events=1
>2014-07-16 02:17:32.059+0000: 4378: debug : virNetMessageDecodeLength:149 : Got length, now need 104 total (100 more)
>2014-07-16 02:17:32.059+0000: 4378: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7f5656b34a10 tx=(nil)
>2014-07-16 02:17:32.059+0000: 4378: debug : virNetServerClientCalculateHandleMode:188 : mode=1
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=37 events=1
>2014-07-16 02:17:32.059+0000: 4378: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140008766417024
>2014-07-16 02:17:32.059+0000: 4378: debug : virNetServerClientDispatchRead:1202 : RPC_SERVER_CLIENT_MSG_RX: client=0x7f5656b345f0 len=104 prog=536903814 vers=1 proc=266 type=0 status=0 serial=5
>2014-07-16 02:17:32.060+0000: 4378: debug : virKeepAliveCheckMessage:374 : ka=0x7f5656b34b50, client=0x7f5656b345f0, msg=0x7f5656b34a10
>2014-07-16 02:17:32.060+0000: 4378: debug : virEventPollUpdateTimeout:260 : EVENT_POLL_UPDATE_TIMEOUT: timer=4 frequency=5000
>2014-07-16 02:17:32.060+0000: 4378: debug : virEventPollUpdateTimeout:278 : Set timer freq=5000 expires=1405477057060
>2014-07-16 02:17:32.060+0000: 4378: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140008766417024
>2014-07-16 02:17:32.060+0000: 4378: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5656b345f0
>2014-07-16 02:17:32.060+0000: 4378: debug : virNetServerDispatchNewMessage:214 : server=0x7f5656b24720 client=0x7f5656b345f0 message=0x7f5656b34a10
>2014-07-16 02:17:32.060+0000: 4378: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5656b2f100
>2014-07-16 02:17:32.060+0000: 4378: debug : virNetMessageNew:44 : msg=0x7f5656b34490 tracked=1
>2014-07-16 02:17:32.060+0000: 4378: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7f5656b34490 tx=(nil)
>2014-07-16 02:17:32.060+0000: 4378: debug : virNetServerClientCalculateHandleMode:188 : mode=1
>2014-07-16 02:17:32.060+0000: 4380: debug : virNetServerHandleJob:185 : server=0x7f5656b24720 client=0x7f5656b345f0 message=0x7f5656b34a10 prog=0x7f5656b2f100
>2014-07-16 02:17:32.060+0000: 4378: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=37 events=1
>2014-07-16 02:17:32.060+0000: 4380: debug : virNetServerProgramDispatch:285 : prog=536903814 ver=1 type=0 status=0 serial=5 proc=266
>2014-07-16 02:17:32.060+0000: 4378: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140008766417024
>2014-07-16 02:17:32.060+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 2
>2014-07-16 02:17:32.060+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.060+0000: 4378: debug : virEventRunDefaultImpl:270 : running default event implementation
>2014-07-16 02:17:32.060+0000: 4380: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5620000a90
>2014-07-16 02:17:32.060+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 2
>2014-07-16 02:17:32.060+0000: 4380: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5620000a90
>2014-07-16 02:17:32.060+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.060+0000: 4380: debug : remoteDispatchDomainBlockRebaseHelper:2621 : server=0x7f5656b24720 client=0x7f5656b345f0 msg=0x7f5656b34a10 rerr=0x7f5644f74c80 args=0x7f5620000a30 ret=0x7f5620000c60
>2014-07-16 02:17:32.060+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0
>2014-07-16 02:17:32.060+0000: 4380: debug : virObjectNew:199 : OBJECT_NEW: obj=0x7f5620000af0 classname=virDomain
>2014-07-16 02:17:32.060+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0
>2014-07-16 02:17:32.060+0000: 4380: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5618000a70
>2014-07-16 02:17:32.060+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0
>2014-07-16 02:17:32.060+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0
>2014-07-16 02:17:32.060+0000: 4380: debug : virDomainBlockRebase:21069 : dom=0x7f5620000af0, (VM: name=test, uuid=fcbf1ce6-8f62-4ccd-8d0f-b6a0f612f2db), disk=vda, base=/home/shyu/copy.img, bandwidth=0, flags=8
>2014-07-16 02:17:32.060+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=14 e=1 d=0
>2014-07-16 02:17:32.060+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=13 e=1 d=0
>2014-07-16 02:17:32.060+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0
>2014-07-16 02:17:32.060+0000: 4380: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5656b2fbc0
>2014-07-16 02:17:32.060+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0
>2014-07-16 02:17:32.060+0000: 4380: debug : virAccessManagerCheckDomain:231 : manager=0x7f5656b2fbc0(name=stack) driver=QEMU domain=0x7f561c00db40 perm=21
>2014-07-16 02:17:32.060+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0
>2014-07-16 02:17:32.060+0000: 4380: debug : virAccessManagerCheckDomain:231 : manager=0x7f5656b242c0(name=none) driver=QEMU domain=0x7f561c00db40 perm=21
>2014-07-16 02:17:32.060+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=36, f=26 e=25 d=0
>2014-07-16 02:17:32.060+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=10 w=37, f=23 e=1 d=0
>2014-07-16 02:17:32.060+0000: 4380: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5656b2fbc0
>2014-07-16 02:17:32.060+0000: 4380: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5634152910
>2014-07-16 02:17:32.060+0000: 4378: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 2 timers
>2014-07-16 02:17:32.060+0000: 4380: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5634152910
>2014-07-16 02:17:32.060+0000: 4378: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1405477057060
>2014-07-16 02:17:32.060+0000: 4380: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f561c0030f0
>2014-07-16 02:17:32.060+0000: 4378: debug : virEventPollCalculateTimeout:353 : Schedule timeout then=1405477057060 now=1405477052060
>2014-07-16 02:17:32.060+0000: 4380: debug : qemuDomainObjBeginJobInternal:1038 : Starting job: modify (async=none)
>2014-07-16 02:17:32.060+0000: 4378: debug : virEventPollCalculateTimeout:361 : Timeout at 1405477057060 due in 5000 ms
>2014-07-16 02:17:32.060+0000: 4380: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5634152910
>2014-07-16 02:17:32.060+0000: 4378: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=10 timeout=5000
>2014-07-16 02:17:32.060+0000: 4380: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5634152910
>2014-07-16 02:17:32.060+0000: 4380: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5634152910
>2014-07-16 02:17:32.061+0000: 4380: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5634152910
>2014-07-16 02:17:32.061+0000: 4380: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5634152910
>2014-07-16 02:17:32.062+0000: 4380: warning : virGetUserIDByName:858 : User record for user '107' was not found: No such file or directory
>2014-07-16 02:17:32.062+0000: 4380: warning : virGetGroupIDByName:938 : Group record for user '107' was not found: No such file or directory
>2014-07-16 02:17:32.063+0000: 4380: debug : virStorageFileIsSharedFSType:1311 : Check if path /home/shyu/copy.img with FS magic 4283649346 is shared
>2014-07-16 02:17:32.064+0000: 4380: debug : virFileClose:90 : Closed fd 24
>2014-07-16 02:17:32.064+0000: 4380: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5634152910
>2014-07-16 02:17:32.064+0000: 4380: debug : virDomainLockDiskAttach:254 : plugin=0x7f5634161cb0 dom=0x7f561c0030f0 disk=0x7f561c00e230
>2014-07-16 02:17:32.064+0000: 4380: debug : virDomainLockManagerNew:128 : plugin=0x7f5634161cb0 dom=0x7f561c0030f0 withResources=0
>2014-07-16 02:17:32.064+0000: 4380: debug : virLockManagerPluginGetDriver:289 : plugin=0x7f5634161cb0
>2014-07-16 02:17:32.064+0000: 4380: debug : virLockManagerNew:313 : driver=0x7f56546a0ba0 type=0 nparams=5 params=0x7f5644f74760 flags=0
>2014-07-16 02:17:32.064+0000: 4380: debug : virLockManagerLogParams:107 :   key=uuid type=uuid value=fcbf1ce6-8f62-4ccd-8d0f-b6a0f612f2db
>2014-07-16 02:17:32.064+0000: 4380: debug : virLockManagerLogParams:100 :   key=name type=string value=test
>2014-07-16 02:17:32.064+0000: 4380: debug : virLockManagerLogParams:88 :   key=id type=uint value=2
>2014-07-16 02:17:32.064+0000: 4380: debug : virLockManagerLogParams:88 :   key=pid type=uint value=4566
>2014-07-16 02:17:32.065+0000: 4380: debug : virLockManagerLogParams:103 :   key=uri type=cstring value=qemu:///system
>2014-07-16 02:17:32.065+0000: 4380: debug : virDomainLockManagerAddDisk:86 : Add disk /home/shyu/copy.img
>2014-07-16 02:17:32.065+0000: 4380: debug : virLockManagerAddResource:340 : lock=0x7f56200010f0 type=0 name=/home/shyu/copy.img nparams=0 params=(nil) flags=0
>2014-07-16 02:17:32.065+0000: 4380: debug : virLockManagerAcquire:358 : lock=0x7f56200010f0 state='(null)' flags=0 action=0 fd=(nil)
>2014-07-16 02:17:32.065+0000: 4380: debug : virLockManagerFree:395 : lock=0x7f56200010f0
>2014-07-16 02:17:32.065+0000: 4380: debug : qemuSetupDiskPathAllow:59 : Process path /home/shyu/copy.img for disk
>2014-07-16 02:17:32.065+0000: 4380: info : virSecuritySELinuxSetFileconHelper:894 : Setting SELinux context on '/home/shyu/copy.img' to 'system_u:object_r:svirt_image_t:s0:c649,c818'
>2014-07-16 02:17:32.065+0000: 4380: debug : virStorageFileIsSharedFSType:1311 : Check if path /home/shyu/copy.img with FS magic 4283649346 is shared
>2014-07-16 02:17:32.065+0000: 4380: info : virSecuritySELinuxSetFileconHelper:934 : Setting security context 'system_u:object_r:svirt_image_t:s0:c649,c818' on '/home/shyu/copy.img' not supported
>2014-07-16 02:17:32.066+0000: 4380: warning : virGetUserIDByName:858 : User record for user '107' was not found: No such file or directory
>2014-07-16 02:17:32.066+0000: 4380: warning : virGetGroupIDByName:938 : Group record for user '107' was not found: No such file or directory
>2014-07-16 02:17:32.066+0000: 4380: info : virSecurityDACSetOwnership:255 : Setting DAC user and group on '/home/shyu/copy.img' to '107:107'
>2014-07-16 02:17:32.066+0000: 4380: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5634152910
>2014-07-16 02:17:32.066+0000: 4380: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f561c0032c0
>2014-07-16 02:17:32.066+0000: 4380: debug : qemuMonitorDriveMirror:3131 : mon=0x7f561c0032c0, device=drive-virtio-disk0, file=/home/shyu/copy.img, format=qcow2, bandwidth=0, flags=0
>2014-07-16 02:17:32.066+0000: 4380: debug : virJSONValueToString:1100 : object=0x7f5620000990
>2014-07-16 02:17:32.066+0000: 4380: debug : virJSONValueToStringOne:1031 : object=0x7f5620000990 type=0 gen=0x7f5620001450
>2014-07-16 02:17:32.066+0000: 4380: debug : virJSONValueToStringOne:1031 : object=0x7f56200010d0 type=2 gen=0x7f5620001450
>2014-07-16 02:17:32.066+0000: 4380: debug : virJSONValueToStringOne:1031 : object=0x7f56200008c0 type=0 gen=0x7f5620001450
>2014-07-16 02:17:32.066+0000: 4380: debug : virJSONValueToStringOne:1031 : object=0x7f56200008e0 type=2 gen=0x7f5620001450
>2014-07-16 02:17:32.066+0000: 4380: debug : virJSONValueToStringOne:1031 : object=0x7f5620000e60 type=2 gen=0x7f5620001450
>2014-07-16 02:17:32.066+0000: 4380: debug : virJSONValueToStringOne:1031 : object=0x7f5620000f10 type=3 gen=0x7f5620001450
>2014-07-16 02:17:32.066+0000: 4380: debug : virJSONValueToStringOne:1031 : object=0x7f5620000f90 type=2 gen=0x7f5620001450
>2014-07-16 02:17:32.066+0000: 4380: debug : virJSONValueToStringOne:1031 : object=0x7f56200011f0 type=2 gen=0x7f5620001450
>2014-07-16 02:17:32.066+0000: 4380: debug : virJSONValueToStringOne:1031 : object=0x7f5620001250 type=2 gen=0x7f5620001450
>2014-07-16 02:17:32.066+0000: 4380: debug : virJSONValueToStringOne:1031 : object=0x7f5620001360 type=2 gen=0x7f5620001450
>2014-07-16 02:17:32.066+0000: 4380: debug : virJSONValueToString:1133 : result={"execute":"drive-mirror","arguments":{"device":"drive-virtio-disk0","target":"/home/shyu/copy.img","speed":0,"sync":"full","mode":"absolute-paths","format":"qcow2"},"id":"libvirt-8"}
>2014-07-16 02:17:32.066+0000: 4380: debug : qemuMonitorJSONCommandWithFd:264 : Send command '{"execute":"drive-mirror","arguments":{"device":"drive-virtio-disk0","target":"/home/shyu/copy.img","speed":0,"sync":"full","mode":"absolute-paths","format":"qcow2"},"id":"libvirt-8"}' for write with FD -1
>2014-07-16 02:17:32.066+0000: 4380: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=36 events=15
>2014-07-16 02:17:32.066+0000: 4380: debug : virEventPollInterruptLocked:714 : Interrupting
>2014-07-16 02:17:32.066+0000: 4380: debug : qemuMonitorSend:955 : QEMU_MONITOR_SEND_MSG: mon=0x7f561c0032c0 msg={"execute":"drive-mirror","arguments":{"device":"drive-virtio-disk0","target":"/home/shyu/copy.img","speed":0,"sync":"full","mode":"absolute-paths","format":"qcow2"},"id":"libvirt-8"}
> fd=-1
>2014-07-16 02:17:32.066+0000: 4378: debug : virEventPollRunOnce:638 : Poll got 1 event(s)
>2014-07-16 02:17:32.066+0000: 4378: debug : virEventPollDispatchTimeouts:423 : Dispatch 2
>2014-07-16 02:17:32.066+0000: 4378: debug : virEventPollDispatchHandles:468 : Dispatch 10
>2014-07-16 02:17:32.066+0000: 4378: debug : virEventPollDispatchHandles:482 : i=0 w=1
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollDispatchHandles:482 : i=1 w=2
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollDispatchHandles:482 : i=2 w=3
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollDispatchHandles:482 : i=3 w=4
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollDispatchHandles:482 : i=4 w=5
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollDispatchHandles:482 : i=5 w=6
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollDispatchHandles:482 : i=7 w=8
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollDispatchHandles:482 : i=8 w=9
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollDispatchHandles:482 : i=9 w=36
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollDispatchHandles:482 : i=10 w=37
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 2
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventRunDefaultImpl:270 : running default event implementation
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 2
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=14 e=1 d=0
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=13 e=1 d=0
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=36, f=26 e=29 d=0
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=10 w=37, f=23 e=1 d=0
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 2 timers
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1405477057060
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollCalculateTimeout:353 : Schedule timeout then=1405477057060 now=1405477052067
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollCalculateTimeout:361 : Timeout at 1405477057060 due in 4993 ms
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=10 timeout=4993
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollRunOnce:638 : Poll got 1 event(s)
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollDispatchTimeouts:423 : Dispatch 2
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollDispatchHandles:468 : Dispatch 10
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollDispatchHandles:482 : i=0 w=1
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollDispatchHandles:482 : i=1 w=2
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollDispatchHandles:482 : i=2 w=3
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollDispatchHandles:482 : i=3 w=4
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollDispatchHandles:482 : i=4 w=5
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollDispatchHandles:482 : i=5 w=6
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollDispatchHandles:482 : i=7 w=8
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollDispatchHandles:482 : i=8 w=9
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollDispatchHandles:482 : i=9 w=36
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=36 events=2
>2014-07-16 02:17:32.067+0000: 4378: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f561c0032c0
>2014-07-16 02:17:32.067+0000: 4378: debug : qemuMonitorIOWrite:502 : QEMU_MONITOR_IO_WRITE: mon=0x7f561c0032c0 buf={"execute":"drive-mirror","arguments":{"device":"drive-virtio-disk0","target":"/home/shyu/copy.img","speed":0,"sync":"full","mode":"absolute-paths","format":"qcow2"},"id":"libvirt-8"}
> len=185 ret=185 errno=2
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=36 events=13
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140008766417024
>2014-07-16 02:17:32.067+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f561c0032c0
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollDispatchHandles:482 : i=10 w=37
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 2
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventRunDefaultImpl:270 : running default event implementation
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 2
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=14 e=1 d=0
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=13 e=1 d=0
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=36, f=26 e=25 d=0
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=10 w=37, f=23 e=1 d=0
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 2 timers
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1405477057060
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollCalculateTimeout:353 : Schedule timeout then=1405477057060 now=1405477052067
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollCalculateTimeout:361 : Timeout at 1405477057060 due in 4993 ms
>2014-07-16 02:17:32.067+0000: 4378: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=10 timeout=4993
>2014-07-16 02:17:32.086+0000: 4378: debug : virEventPollRunOnce:638 : Poll got 1 event(s)
>2014-07-16 02:17:32.086+0000: 4378: debug : virEventPollDispatchTimeouts:423 : Dispatch 2
>2014-07-16 02:17:32.086+0000: 4378: debug : virEventPollDispatchHandles:468 : Dispatch 10
>2014-07-16 02:17:32.086+0000: 4378: debug : virEventPollDispatchHandles:482 : i=0 w=1
>2014-07-16 02:17:32.086+0000: 4378: debug : virEventPollDispatchHandles:482 : i=1 w=2
>2014-07-16 02:17:32.086+0000: 4378: debug : virEventPollDispatchHandles:482 : i=2 w=3
>2014-07-16 02:17:32.086+0000: 4378: debug : virEventPollDispatchHandles:482 : i=3 w=4
>2014-07-16 02:17:32.086+0000: 4378: debug : virEventPollDispatchHandles:482 : i=4 w=5
>2014-07-16 02:17:32.086+0000: 4378: debug : virEventPollDispatchHandles:482 : i=5 w=6
>2014-07-16 02:17:32.086+0000: 4378: debug : virEventPollDispatchHandles:482 : i=7 w=8
>2014-07-16 02:17:32.086+0000: 4378: debug : virEventPollDispatchHandles:482 : i=8 w=9
>2014-07-16 02:17:32.086+0000: 4378: debug : virEventPollDispatchHandles:482 : i=9 w=36
>2014-07-16 02:17:32.086+0000: 4378: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=36 events=1
>2014-07-16 02:17:32.086+0000: 4378: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f561c0032c0
>2014-07-16 02:17:32.086+0000: 4378: debug : qemuMonitorIOProcess:394 : QEMU_MONITOR_IO_PROCESS: mon=0x7f561c0032c0 buf={"id": "libvirt-8", "error": {"class": "GenericError", "desc": "Could not open file: Invalid argument"}}
> len=106
>2014-07-16 02:17:32.086+0000: 4378: debug : qemuMonitorJSONIOProcessLine:157 : Line [{"id": "libvirt-8", "error": {"class": "GenericError", "desc": "Could not open file: Invalid argument"}}]
>2014-07-16 02:17:32.087+0000: 4378: debug : virJSONValueFromString:976 : string={"id": "libvirt-8", "error": {"class": "GenericError", "desc": "Could not open file: Invalid argument"}}
>2014-07-16 02:17:32.087+0000: 4378: debug : virJSONParserHandleStartMap:853 : parser=0x7fff9d1c3560
>2014-07-16 02:17:32.087+0000: 4378: debug : virJSONParserHandleMapKey:835 : parser=0x7fff9d1c3560 key=0x7f5656b32e82
>2014-07-16 02:17:32.087+0000: 4378: debug : virJSONParserHandleString:815 : parser=0x7fff9d1c3560 str=0x7f5656b32e88
>2014-07-16 02:17:32.087+0000: 4378: debug : virJSONParserHandleMapKey:835 : parser=0x7fff9d1c3560 key=0x7f5656b32e95
>2014-07-16 02:17:32.087+0000: 4378: debug : virJSONParserHandleStartMap:853 : parser=0x7fff9d1c3560
>2014-07-16 02:17:32.087+0000: 4378: debug : virJSONParserHandleMapKey:835 : parser=0x7fff9d1c3560 key=0x7f5656b32e9f
>2014-07-16 02:17:32.087+0000: 4378: debug : virJSONParserHandleString:815 : parser=0x7fff9d1c3560 str=0x7f5656b32ea8
>2014-07-16 02:17:32.087+0000: 4378: debug : virJSONParserHandleMapKey:835 : parser=0x7fff9d1c3560 key=0x7f5656b32eb8
>2014-07-16 02:17:32.087+0000: 4378: debug : virJSONParserHandleString:815 : parser=0x7fff9d1c3560 str=0x7f5656b32ec0
>2014-07-16 02:17:32.087+0000: 4378: debug : virJSONParserHandleEndMap:882 : parser=0x7fff9d1c3560
>2014-07-16 02:17:32.087+0000: 4378: debug : virJSONParserHandleEndMap:882 : parser=0x7fff9d1c3560
>2014-07-16 02:17:32.087+0000: 4378: debug : virJSONValueFromString:1020 : result=0x7f5656abd520
>2014-07-16 02:17:32.087+0000: 4378: debug : qemuMonitorJSONIOProcessLine:177 : QEMU_MONITOR_RECV_REPLY: mon=0x7f561c0032c0 reply={"id": "libvirt-8", "error": {"class": "GenericError", "desc": "Could not open file: Invalid argument"}}
>2014-07-16 02:17:32.087+0000: 4378: debug : qemuMonitorJSONIOProcess:226 : Total used 106 bytes out of 106 available in buffer
>2014-07-16 02:17:32.087+0000: 4378: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=36 events=13
>2014-07-16 02:17:32.087+0000: 4378: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140008766417024
>2014-07-16 02:17:32.087+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f561c0032c0
>2014-07-16 02:17:32.087+0000: 4378: debug : virEventPollDispatchHandles:482 : i=10 w=37
>2014-07-16 02:17:32.087+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 2
>2014-07-16 02:17:32.087+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.087+0000: 4380: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=36 events=13
>2014-07-16 02:17:32.087+0000: 4378: debug : virEventRunDefaultImpl:270 : running default event implementation
>2014-07-16 02:17:32.087+0000: 4380: debug : virEventPollInterruptLocked:710 : Skip interrupt, 0 140008766417024
>2014-07-16 02:17:32.087+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 2
>2014-07-16 02:17:32.087+0000: 4380: debug : qemuMonitorJSONCommandWithFd:269 : Receive command reply ret=0 rxObject=0x7f5656abd520
>2014-07-16 02:17:32.087+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.087+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0
>2014-07-16 02:17:32.087+0000: 4380: debug : virJSONValueToString:1100 : object=0x7f5620000990
>2014-07-16 02:17:32.087+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0
>2014-07-16 02:17:32.087+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0
>2014-07-16 02:17:32.087+0000: 4380: debug : virJSONValueToStringOne:1031 : object=0x7f5620000990 type=0 gen=0x7f56200013c0
>2014-07-16 02:17:32.087+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0
>2014-07-16 02:17:32.087+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=14 e=1 d=0
>2014-07-16 02:17:32.087+0000: 4380: debug : virJSONValueToStringOne:1031 : object=0x7f56200010d0 type=2 gen=0x7f56200013c0
>2014-07-16 02:17:32.087+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=13 e=1 d=0
>2014-07-16 02:17:32.087+0000: 4380: debug : virJSONValueToStringOne:1031 : object=0x7f56200008c0 type=0 gen=0x7f56200013c0
>2014-07-16 02:17:32.087+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0
>2014-07-16 02:17:32.087+0000: 4380: debug : virJSONValueToStringOne:1031 : object=0x7f56200008e0 type=2 gen=0x7f56200013c0
>2014-07-16 02:17:32.087+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0
>2014-07-16 02:17:32.087+0000: 4380: debug : virJSONValueToStringOne:1031 : object=0x7f5620000e60 type=2 gen=0x7f56200013c0
>2014-07-16 02:17:32.087+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0
>2014-07-16 02:17:32.087+0000: 4380: debug : virJSONValueToStringOne:1031 : object=0x7f5620000f10 type=3 gen=0x7f56200013c0
>2014-07-16 02:17:32.087+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=36, f=26 e=25 d=0
>2014-07-16 02:17:32.087+0000: 4380: debug : virJSONValueToStringOne:1031 : object=0x7f5620000f90 type=2 gen=0x7f56200013c0
>2014-07-16 02:17:32.087+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=10 w=37, f=23 e=1 d=0
>2014-07-16 02:17:32.087+0000: 4380: debug : virJSONValueToStringOne:1031 : object=0x7f56200011f0 type=2 gen=0x7f56200013c0
>2014-07-16 02:17:32.087+0000: 4378: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 2 timers
>2014-07-16 02:17:32.087+0000: 4380: debug : virJSONValueToStringOne:1031 : object=0x7f5620001250 type=2 gen=0x7f56200013c0
>2014-07-16 02:17:32.087+0000: 4378: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1405477057060
>2014-07-16 02:17:32.087+0000: 4380: debug : virJSONValueToStringOne:1031 : object=0x7f5620001360 type=2 gen=0x7f56200013c0
>2014-07-16 02:17:32.087+0000: 4378: debug : virEventPollCalculateTimeout:353 : Schedule timeout then=1405477057060 now=1405477052087
>2014-07-16 02:17:32.087+0000: 4380: debug : virJSONValueToString:1133 : result={"execute":"drive-mirror","arguments":{"device":"drive-virtio-disk0","target":"/home/shyu/copy.img","speed":0,"sync":"full","mode":"absolute-paths","format":"qcow2"},"id":"libvirt-8"}
>2014-07-16 02:17:32.087+0000: 4378: debug : virEventPollCalculateTimeout:361 : Timeout at 1405477057060 due in 4973 ms
>2014-07-16 02:17:32.087+0000: 4380: debug : virJSONValueToString:1100 : object=0x7f5656abd520
>2014-07-16 02:17:32.087+0000: 4378: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=10 timeout=4973
>2014-07-16 02:17:32.087+0000: 4380: debug : virJSONValueToStringOne:1031 : object=0x7f5656abd520 type=0 gen=0x7f5620001780
>2014-07-16 02:17:32.087+0000: 4380: debug : virJSONValueToStringOne:1031 : object=0x7f5656b01bb0 type=2 gen=0x7f5620001780
>2014-07-16 02:17:32.087+0000: 4380: debug : virJSONValueToStringOne:1031 : object=0x7f5656ab6c80 type=0 gen=0x7f5620001780
>2014-07-16 02:17:32.087+0000: 4380: debug : virJSONValueToStringOne:1031 : object=0x7f5656b33b90 type=2 gen=0x7f5620001780
>2014-07-16 02:17:32.087+0000: 4380: debug : virJSONValueToStringOne:1031 : object=0x7f5656abfac0 type=2 gen=0x7f5620001780
>2014-07-16 02:17:32.087+0000: 4380: debug : virJSONValueToString:1133 : result={"id":"libvirt-8","error":{"class":"GenericError","desc":"Could not open file: Invalid argument"}}
>2014-07-16 02:17:32.088+0000: 4380: debug : qemuMonitorJSONCheckError:343 : unable to execute QEMU command {"execute":"drive-mirror","arguments":{"device":"drive-virtio-disk0","target":"/home/shyu/copy.img","speed":0,"sync":"full","mode":"absolute-paths","format":"qcow2"},"id":"libvirt-8"}: {"id":"libvirt-8","error":{"class":"GenericError","desc":"Could not open file: Invalid argument"}}
>2014-07-16 02:17:32.088+0000: 4380: error : qemuMonitorJSONCheckError:354 : internal error: unable to execute QEMU command 'drive-mirror': Could not open file: Invalid argument
>2014-07-16 02:17:32.088+0000: 4380: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f561c0032c0
>2014-07-16 02:17:32.088+0000: 4380: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5634152910
>2014-07-16 02:17:32.088+0000: 4380: info : virSecurityDACRestoreSecurityFileLabel:299 : Restoring DAC user and group on '/home/shyu/copy.img'
>2014-07-16 02:17:32.088+0000: 4380: info : virSecurityDACSetOwnership:255 : Setting DAC user and group on '/home/shyu/copy.img' to '0:0'
>2014-07-16 02:17:32.088+0000: 4380: debug : qemuTeardownDiskPathDeny:101 : Process path /home/shyu/copy.img for disk
>2014-07-16 02:17:32.088+0000: 4380: debug : virDomainLockDiskDetach:282 : plugin=0x7f5634161cb0 dom=0x7f561c0030f0 disk=0x7f561c00e230
>2014-07-16 02:17:32.088+0000: 4380: debug : virDomainLockManagerNew:128 : plugin=0x7f5634161cb0 dom=0x7f561c0030f0 withResources=0
>2014-07-16 02:17:32.088+0000: 4380: debug : virLockManagerPluginGetDriver:289 : plugin=0x7f5634161cb0
>2014-07-16 02:17:32.088+0000: 4380: debug : virLockManagerNew:313 : driver=0x7f56546a0ba0 type=0 nparams=5 params=0x7f5644f74770 flags=0
>2014-07-16 02:17:32.088+0000: 4380: debug : virLockManagerLogParams:107 :   key=uuid type=uuid value=fcbf1ce6-8f62-4ccd-8d0f-b6a0f612f2db
>2014-07-16 02:17:32.088+0000: 4380: debug : virLockManagerLogParams:100 :   key=name type=string value=test
>2014-07-16 02:17:32.088+0000: 4380: debug : virLockManagerLogParams:88 :   key=id type=uint value=2
>2014-07-16 02:17:32.088+0000: 4380: debug : virLockManagerLogParams:88 :   key=pid type=uint value=4566
>2014-07-16 02:17:32.088+0000: 4380: debug : virLockManagerLogParams:103 :   key=uri type=cstring value=(null)
>2014-07-16 02:17:32.088+0000: 4380: debug : virDomainLockManagerAddDisk:86 : Add disk /home/shyu/copy.img
>2014-07-16 02:17:32.088+0000: 4380: debug : virLockManagerAddResource:340 : lock=0x7f5620000de0 type=0 name=/home/shyu/copy.img nparams=0 params=(nil) flags=0
>2014-07-16 02:17:32.088+0000: 4380: debug : virLockManagerRelease:373 : lock=0x7f5620000de0 state=(nil) flags=0
>2014-07-16 02:17:32.088+0000: 4380: debug : virLockManagerFree:395 : lock=0x7f5620000de0
>2014-07-16 02:17:32.088+0000: 4380: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5634152910
>2014-07-16 02:17:32.089+0000: 4380: debug : qemuDomainObjEndJob:1150 : Stopping job: modify (async=none)
>2014-07-16 02:17:32.089+0000: 4380: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f561c0030f0
>2014-07-16 02:17:32.089+0000: 4380: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5634152910
>2014-07-16 02:17:32.089+0000: 4380: debug : virDomainFree:2428 : dom=0x7f5620000af0, (VM: name=test, uuid=fcbf1ce6-8f62-4ccd-8d0f-b6a0f612f2db)
>2014-07-16 02:17:32.089+0000: 4380: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5620000af0
>2014-07-16 02:17:32.089+0000: 4380: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f5620000af0
>2014-07-16 02:17:32.089+0000: 4380: debug : virDomainDispose:262 : release domain 0x7f5620000af0 test fcbf1ce6-8f62-4ccd-8d0f-b6a0f612f2db
>2014-07-16 02:17:32.089+0000: 4380: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5618000a70
>2014-07-16 02:17:32.089+0000: 4380: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5620000a90
>2014-07-16 02:17:32.089+0000: 4380: debug : virNetServerProgramSendError:151 : prog=536903814 ver=1 proc=266 type=1 serial=5 msg=0x7f5656b34a10 rerr=0x7f5644f74c80
>2014-07-16 02:17:32.089+0000: 4380: debug : virNetMessageEncodePayload:374 : Encode length as 288
>2014-07-16 02:17:32.089+0000: 4380: debug : virNetServerClientSendMessageLocked:1451 : msg=0x7f5656b34a10 proc=266 len=288 offset=0
>2014-07-16 02:17:32.089+0000: 4380: debug : virNetServerClientSendMessageLocked:1459 : RPC_SERVER_CLIENT_MSG_TX_QUEUE: client=0x7f5656b345f0 len=288 prog=536903814 vers=1 proc=266 type=1 status=1 serial=5
>2014-07-16 02:17:32.089+0000: 4380: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7f5656b34490 tx=0x7f5656b34a10
>2014-07-16 02:17:32.089+0000: 4380: debug : virNetServerClientCalculateHandleMode:188 : mode=3
>2014-07-16 02:17:32.089+0000: 4380: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=37 events=3
>2014-07-16 02:17:32.089+0000: 4380: debug : virEventPollInterruptLocked:714 : Interrupting
>2014-07-16 02:17:32.089+0000: 4380: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5620000a90
>2014-07-16 02:17:32.089+0000: 4380: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5656b2f100
>2014-07-16 02:17:32.089+0000: 4378: debug : virEventPollRunOnce:638 : Poll got 1 event(s)
>2014-07-16 02:17:32.089+0000: 4380: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5656b345f0
>2014-07-16 02:17:32.089+0000: 4378: debug : virEventPollDispatchTimeouts:423 : Dispatch 2
>2014-07-16 02:17:32.089+0000: 4378: debug : virEventPollDispatchHandles:468 : Dispatch 10
>2014-07-16 02:17:32.089+0000: 4378: debug : virEventPollDispatchHandles:482 : i=0 w=1
>2014-07-16 02:17:32.089+0000: 4378: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollDispatchHandles:482 : i=1 w=2
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollDispatchHandles:482 : i=2 w=3
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollDispatchHandles:482 : i=3 w=4
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollDispatchHandles:482 : i=4 w=5
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollDispatchHandles:482 : i=5 w=6
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollDispatchHandles:482 : i=7 w=8
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollDispatchHandles:482 : i=8 w=9
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollDispatchHandles:482 : i=9 w=36
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollDispatchHandles:482 : i=10 w=37
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 2
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventRunDefaultImpl:270 : running default event implementation
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 2
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=14 e=1 d=0
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=13 e=1 d=0
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=36, f=26 e=25 d=0
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=10 w=37, f=23 e=5 d=0
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 2 timers
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1405477057060
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollCalculateTimeout:353 : Schedule timeout then=1405477057060 now=1405477052090
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollCalculateTimeout:361 : Timeout at 1405477057060 due in 4970 ms
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=10 timeout=4970
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollRunOnce:638 : Poll got 1 event(s)
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollDispatchTimeouts:423 : Dispatch 2
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollDispatchHandles:468 : Dispatch 10
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollDispatchHandles:482 : i=0 w=1
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollDispatchHandles:482 : i=1 w=2
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollDispatchHandles:482 : i=2 w=3
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollDispatchHandles:482 : i=3 w=4
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollDispatchHandles:482 : i=4 w=5
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollDispatchHandles:482 : i=5 w=6
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollDispatchHandles:482 : i=7 w=8
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollDispatchHandles:482 : i=8 w=9
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollDispatchHandles:482 : i=9 w=36
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollDispatchHandles:482 : i=10 w=37
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=37 events=2
>2014-07-16 02:17:32.090+0000: 4378: debug : virNetMessageFree:72 : msg=0x7f5656b34a10 nfds=0 cb=(nil)
>2014-07-16 02:17:32.090+0000: 4378: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7f5656b34490 tx=(nil)
>2014-07-16 02:17:32.090+0000: 4378: debug : virNetServerClientCalculateHandleMode:188 : mode=1
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=37 events=1
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140008766417024
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 2
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventRunDefaultImpl:270 : running default event implementation
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 2
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=14 e=1 d=0
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=13 e=1 d=0
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=36, f=26 e=25 d=0
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=10 w=37, f=23 e=1 d=0
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 2 timers
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1405477057060
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollCalculateTimeout:353 : Schedule timeout then=1405477057060 now=1405477052090
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollCalculateTimeout:361 : Timeout at 1405477057060 due in 4970 ms
>2014-07-16 02:17:32.090+0000: 4378: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=10 timeout=4970
>2014-07-16 02:17:32.091+0000: 4378: debug : virEventPollRunOnce:638 : Poll got 1 event(s)
>2014-07-16 02:17:32.091+0000: 4378: debug : virEventPollDispatchTimeouts:423 : Dispatch 2
>2014-07-16 02:17:32.091+0000: 4378: debug : virEventPollDispatchHandles:468 : Dispatch 10
>2014-07-16 02:17:32.091+0000: 4378: debug : virEventPollDispatchHandles:482 : i=0 w=1
>2014-07-16 02:17:32.091+0000: 4378: debug : virEventPollDispatchHandles:482 : i=1 w=2
>2014-07-16 02:17:32.091+0000: 4378: debug : virEventPollDispatchHandles:482 : i=2 w=3
>2014-07-16 02:17:32.091+0000: 4378: debug : virEventPollDispatchHandles:482 : i=3 w=4
>2014-07-16 02:17:32.091+0000: 4378: debug : virEventPollDispatchHandles:482 : i=4 w=5
>2014-07-16 02:17:32.091+0000: 4378: debug : virEventPollDispatchHandles:482 : i=5 w=6
>2014-07-16 02:17:32.091+0000: 4378: debug : virEventPollDispatchHandles:482 : i=7 w=8
>2014-07-16 02:17:32.091+0000: 4378: debug : virEventPollDispatchHandles:482 : i=8 w=9
>2014-07-16 02:17:32.091+0000: 4378: debug : virEventPollDispatchHandles:482 : i=9 w=36
>2014-07-16 02:17:32.091+0000: 4378: debug : virEventPollDispatchHandles:482 : i=10 w=37
>2014-07-16 02:17:32.091+0000: 4378: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=37 events=1
>2014-07-16 02:17:32.091+0000: 4378: debug : virNetMessageDecodeLength:149 : Got length, now need 28 total (24 more)
>2014-07-16 02:17:32.091+0000: 4378: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7f5656b34490 tx=(nil)
>2014-07-16 02:17:32.091+0000: 4378: debug : virNetServerClientCalculateHandleMode:188 : mode=1
>2014-07-16 02:17:32.091+0000: 4378: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=37 events=1
>2014-07-16 02:17:32.091+0000: 4378: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140008766417024
>2014-07-16 02:17:32.091+0000: 4378: debug : virNetServerClientDispatchRead:1202 : RPC_SERVER_CLIENT_MSG_RX: client=0x7f5656b345f0 len=28 prog=536903814 vers=1 proc=2 type=0 status=0 serial=6
>2014-07-16 02:17:32.091+0000: 4378: debug : virKeepAliveCheckMessage:374 : ka=0x7f5656b34b50, client=0x7f5656b345f0, msg=0x7f5656b34490
>2014-07-16 02:17:32.091+0000: 4378: debug : virEventPollUpdateTimeout:260 : EVENT_POLL_UPDATE_TIMEOUT: timer=4 frequency=5000
>2014-07-16 02:17:32.091+0000: 4378: debug : virEventPollUpdateTimeout:278 : Set timer freq=5000 expires=1405477057091
>2014-07-16 02:17:32.091+0000: 4378: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140008766417024
>2014-07-16 02:17:32.091+0000: 4378: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5656b345f0
>2014-07-16 02:17:32.091+0000: 4378: debug : virNetServerDispatchNewMessage:214 : server=0x7f5656b24720 client=0x7f5656b345f0 message=0x7f5656b34490
>2014-07-16 02:17:32.091+0000: 4378: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5656b2f100
>2014-07-16 02:17:32.091+0000: 4378: debug : virNetMessageNew:44 : msg=0x7f5656b35590 tracked=1
>2014-07-16 02:17:32.091+0000: 4378: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7f5656b35590 tx=(nil)
>2014-07-16 02:17:32.091+0000: 4381: debug : virNetServerHandleJob:185 : server=0x7f5656b24720 client=0x7f5656b345f0 message=0x7f5656b34490 prog=0x7f5656b2f100
>2014-07-16 02:17:32.091+0000: 4378: debug : virNetServerClientCalculateHandleMode:188 : mode=1
>2014-07-16 02:17:32.091+0000: 4381: debug : virNetServerProgramDispatch:285 : prog=536903814 ver=1 type=0 status=0 serial=6 proc=2
>2014-07-16 02:17:32.091+0000: 4378: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=37 events=1
>2014-07-16 02:17:32.091+0000: 4378: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140008766417024
>2014-07-16 02:17:32.091+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 2
>2014-07-16 02:17:32.091+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.091+0000: 4381: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5620000a90
>2014-07-16 02:17:32.091+0000: 4381: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5620000a90
>2014-07-16 02:17:32.091+0000: 4378: debug : virEventRunDefaultImpl:270 : running default event implementation
>2014-07-16 02:17:32.091+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 2
>2014-07-16 02:17:32.091+0000: 4381: debug : remoteDispatchConnectCloseHelper:174 : server=0x7f5656b24720 client=0x7f5656b345f0 msg=0x7f5656b34490 rerr=0x7f5644773c80 args=0x7f5624002b20 ret=0x7f5624002b40
>2014-07-16 02:17:32.091+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.091+0000: 4381: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5620000a90
>2014-07-16 02:17:32.091+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0
>2014-07-16 02:17:32.091+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0
>2014-07-16 02:17:32.091+0000: 4381: debug : virNetMessageEncodePayload:374 : Encode length as 28
>2014-07-16 02:17:32.091+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0
>2014-07-16 02:17:32.091+0000: 4381: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5620000a90
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0
>2014-07-16 02:17:32.092+0000: 4381: debug : virNetServerClientSendMessageLocked:1451 : msg=0x7f5656b34490 proc=2 len=28 offset=0
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=14 e=1 d=0
>2014-07-16 02:17:32.092+0000: 4381: debug : virNetServerClientSendMessageLocked:1459 : RPC_SERVER_CLIENT_MSG_TX_QUEUE: client=0x7f5656b345f0 len=28 prog=536903814 vers=1 proc=2 type=1 status=0 serial=6
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=13 e=1 d=0
>2014-07-16 02:17:32.092+0000: 4381: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7f5656b35590 tx=0x7f5656b34490
>2014-07-16 02:17:32.092+0000: 4381: debug : virNetServerClientCalculateHandleMode:188 : mode=2
>2014-07-16 02:17:32.092+0000: 4381: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=37 events=2
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=36, f=26 e=25 d=0
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=10 w=37, f=23 e=1 d=0
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 2 timers
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1405477057091
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollCalculateTimeout:353 : Schedule timeout then=1405477057091 now=1405477052092
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollCalculateTimeout:361 : Timeout at 1405477057091 due in 4999 ms
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=10 timeout=4999
>2014-07-16 02:17:32.092+0000: 4381: debug : virEventPollInterruptLocked:714 : Interrupting
>2014-07-16 02:17:32.092+0000: 4381: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5656b2f100
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollRunOnce:638 : Poll got 1 event(s)
>2014-07-16 02:17:32.092+0000: 4381: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5656b345f0
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollDispatchTimeouts:423 : Dispatch 2
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollDispatchHandles:468 : Dispatch 10
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollDispatchHandles:482 : i=0 w=1
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollDispatchHandles:482 : i=1 w=2
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollDispatchHandles:482 : i=2 w=3
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollDispatchHandles:482 : i=3 w=4
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollDispatchHandles:482 : i=4 w=5
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollDispatchHandles:482 : i=5 w=6
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollDispatchHandles:482 : i=7 w=8
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollDispatchHandles:482 : i=8 w=9
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollDispatchHandles:482 : i=9 w=36
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollDispatchHandles:482 : i=10 w=37
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 2
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventRunDefaultImpl:270 : running default event implementation
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 2
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=14 e=1 d=0
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=13 e=1 d=0
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=36, f=26 e=25 d=0
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=10 w=37, f=23 e=4 d=0
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 2 timers
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1405477057091
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollCalculateTimeout:353 : Schedule timeout then=1405477057091 now=1405477052092
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollCalculateTimeout:361 : Timeout at 1405477057091 due in 4999 ms
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=10 timeout=4999
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollRunOnce:638 : Poll got 1 event(s)
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollDispatchTimeouts:423 : Dispatch 2
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollDispatchHandles:468 : Dispatch 10
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollDispatchHandles:482 : i=0 w=1
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollDispatchHandles:482 : i=1 w=2
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollDispatchHandles:482 : i=2 w=3
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollDispatchHandles:482 : i=3 w=4
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollDispatchHandles:482 : i=4 w=5
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollDispatchHandles:482 : i=5 w=6
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollDispatchHandles:482 : i=7 w=8
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollDispatchHandles:482 : i=8 w=9
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollDispatchHandles:482 : i=9 w=36
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollDispatchHandles:482 : i=10 w=37
>2014-07-16 02:17:32.092+0000: 4378: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=37 events=2
>2014-07-16 02:17:32.092+0000: 4378: debug : virNetMessageFree:72 : msg=0x7f5656b34490 nfds=0 cb=(nil)
>2014-07-16 02:17:32.092+0000: 4378: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7f5656b35590 tx=(nil)
>2014-07-16 02:17:32.093+0000: 4378: debug : virNetServerClientCalculateHandleMode:188 : mode=0
>2014-07-16 02:17:32.093+0000: 4378: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=37 events=0
>2014-07-16 02:17:32.093+0000: 4378: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140008766417024
>2014-07-16 02:17:32.093+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 2
>2014-07-16 02:17:32.093+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.093+0000: 4378: debug : virNetServerClientClose:941 : client=0x7f5656b345f0
>2014-07-16 02:17:32.093+0000: 4378: debug : virKeepAliveStop:307 : RPC_KEEPALIVE_STOP: ka=0x7f5656b34b50 client=0x7f5656b345f0
>2014-07-16 02:17:32.093+0000: 4378: debug : virEventPollRemoveTimeout:300 : EVENT_POLL_REMOVE_TIMEOUT: timer=4
>2014-07-16 02:17:32.093+0000: 4378: debug : virEventPollInterruptLocked:710 : Skip interrupt, 0 140008766417024
>2014-07-16 02:17:32.093+0000: 4378: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5656b345f0
>2014-07-16 02:17:32.093+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5656b34b50
>2014-07-16 02:17:32.093+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5656b345f0
>2014-07-16 02:17:32.093+0000: 4378: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5656b345f0
>2014-07-16 02:17:32.093+0000: 4378: debug : daemonRemoveAllClientStreams:486 : stream=(nil)
>2014-07-16 02:17:32.093+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5656b345f0
>2014-07-16 02:17:32.093+0000: 4378: debug : virEventPollRemoveHandle:180 : EVENT_POLL_REMOVE_HANDLE: watch=37
>2014-07-16 02:17:32.093+0000: 4378: debug : virEventPollRemoveHandle:193 : mark delete 10 23
>2014-07-16 02:17:32.093+0000: 4378: debug : virEventPollInterruptLocked:710 : Skip interrupt, 0 140008766417024
>2014-07-16 02:17:32.093+0000: 4378: debug : virNetMessageFree:72 : msg=0x7f5656b35590 nfds=0 cb=(nil)
>2014-07-16 02:17:32.093+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5656b34170
>2014-07-16 02:17:32.093+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5656b345f0
>2014-07-16 02:17:32.093+0000: 4378: debug : virEventRunDefaultImpl:270 : running default event implementation
>2014-07-16 02:17:32.093+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 2
>2014-07-16 02:17:32.093+0000: 4378: debug : virEventPollCleanupTimeouts:527 : EVENT_POLL_PURGE_TIMEOUT: timer=4
>2014-07-16 02:17:32.093+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5656b34b50
>2014-07-16 02:17:32.093+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f5656b34b50
>2014-07-16 02:17:32.093+0000: 4378: debug : virKeepAliveDispose:227 : RPC_KEEPALIVE_DISPOSE: ka=0x7f5656b34b50
>2014-07-16 02:17:32.093+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5656b345f0
>2014-07-16 02:17:32.093+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 11
>2014-07-16 02:17:32.093+0000: 4378: debug : virEventPollCleanupHandles:575 : EVENT_POLL_PURGE_HANDLE: watch=37
>2014-07-16 02:17:32.093+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5656b345f0
>2014-07-16 02:17:32.093+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f5656b345f0
>2014-07-16 02:17:32.093+0000: 4378: debug : virNetServerClientDispose:905 : RPC_SERVER_CLIENT_DISPOSE: client=0x7f5656b345f0
>2014-07-16 02:17:32.093+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5620000a90
>2014-07-16 02:17:32.093+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f5620000a90
>2014-07-16 02:17:32.093+0000: 4378: debug : virFileClose:90 : Closed fd 24
>2014-07-16 02:17:32.093+0000: 4378: debug : virObjectNew:199 : OBJECT_NEW: obj=0x7f5656b34d50 classname=virIdentity
>2014-07-16 02:17:32.093+0000: 4378: debug : virIdentitySetAttr:282 : ident=0x7f5656b34d50 attribute=0 value=root
>2014-07-16 02:17:32.093+0000: 4378: debug : virIdentitySetAttr:282 : ident=0x7f5656b34d50 attribute=1 value=0
>2014-07-16 02:17:32.093+0000: 4378: debug : virIdentitySetAttr:282 : ident=0x7f5656b34d50 attribute=2 value=root
>2014-07-16 02:17:32.093+0000: 4378: debug : virIdentitySetAttr:282 : ident=0x7f5656b34d50 attribute=3 value=0
>2014-07-16 02:17:32.093+0000: 4378: debug : virIdentitySetAttr:282 : ident=0x7f5656b34d50 attribute=8 value=system_u:system_r:virtd_t:s0-s0:c0.c1023
>2014-07-16 02:17:32.093+0000: 4378: debug : virIdentitySetAttr:282 : ident=0x7f5656b34d50 attribute=4 value=4378
>2014-07-16 02:17:32.093+0000: 4378: debug : virIdentitySetAttr:282 : ident=0x7f5656b34d50 attribute=5 value=318199
>2014-07-16 02:17:32.093+0000: 4378: debug : virObjectRef:293 : OBJECT_REF: obj=0x7f5656b34d50
>2014-07-16 02:17:32.093+0000: 4378: debug : virConnectClose:1523 : conn=0x7f5618000a70
>2014-07-16 02:17:32.093+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5618000a70
>2014-07-16 02:17:32.093+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f5618000a70
>2014-07-16 02:17:32.093+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f56340109b0
>2014-07-16 02:17:32.093+0000: 4378: debug : virCloseCallbacksRun:321 : conn=0x7f5618000a70
>2014-07-16 02:17:32.093+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5618000ba0
>2014-07-16 02:17:32.093+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f5618000ba0
>2014-07-16 02:17:32.093+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5656b34d50
>2014-07-16 02:17:32.093+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5656b34d50
>2014-07-16 02:17:32.093+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f5656b34d50
>2014-07-16 02:17:32.093+0000: 4378: debug : virEventPollRemoveTimeout:300 : EVENT_POLL_REMOVE_TIMEOUT: timer=3
>2014-07-16 02:17:32.093+0000: 4378: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140008766417024
>2014-07-16 02:17:32.093+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5656b34170
>2014-07-16 02:17:32.094+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f5656b34170
>2014-07-16 02:17:32.094+0000: 4378: debug : virNetSocketDispose:1002 : RPC_SOCKET_DISPOSE: sock=0x7f5656b34170
>2014-07-16 02:17:32.094+0000: 4378: debug : virEventPollRemoveHandle:180 : EVENT_POLL_REMOVE_HANDLE: watch=37
>2014-07-16 02:17:32.094+0000: 4378: debug : virFileClose:90 : Closed fd 23
>2014-07-16 02:17:32.094+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0
>2014-07-16 02:17:32.094+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0
>2014-07-16 02:17:32.094+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0
>2014-07-16 02:17:32.094+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0
>2014-07-16 02:17:32.094+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=14 e=1 d=0
>2014-07-16 02:17:32.094+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=13 e=1 d=0
>2014-07-16 02:17:32.094+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0
>2014-07-16 02:17:32.094+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0
>2014-07-16 02:17:32.094+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0
>2014-07-16 02:17:32.094+0000: 4378: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=36, f=26 e=25 d=0
>2014-07-16 02:17:32.094+0000: 4378: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 1 timers
>2014-07-16 02:17:32.094+0000: 4378: debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms
>2014-07-16 02:17:32.094+0000: 4378: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=9 timeout=-1
>2014-07-16 02:17:32.147+0000: 4378: debug : virEventPollRunOnce:630 : Poll got error event 4
>2014-07-16 02:17:32.147+0000: 4378: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=9 timeout=-1
>2014-07-16 02:17:32.147+0000: 4378: debug : virEventPollRunOnce:638 : Poll got 1 event(s)
>2014-07-16 02:17:32.147+0000: 4378: debug : virEventPollDispatchTimeouts:423 : Dispatch 1
>2014-07-16 02:17:32.147+0000: 4378: debug : virEventPollDispatchHandles:468 : Dispatch 9
>2014-07-16 02:17:32.147+0000: 4378: debug : virEventPollDispatchHandles:482 : i=0 w=1
>2014-07-16 02:17:32.147+0000: 4378: debug : virEventPollDispatchHandles:482 : i=1 w=2
>2014-07-16 02:17:32.147+0000: 4378: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=2 events=1
>2014-07-16 02:17:32.147+0000: 4378: debug : virNetServerQuit:1169 : Quit requested 0x7f5656b24720
>2014-07-16 02:17:32.147+0000: 4378: debug : virEventPollDispatchHandles:482 : i=2 w=3
>2014-07-16 02:17:32.147+0000: 4378: debug : virEventPollDispatchHandles:482 : i=3 w=4
>2014-07-16 02:17:32.147+0000: 4378: debug : virEventPollDispatchHandles:482 : i=4 w=5
>2014-07-16 02:17:32.147+0000: 4378: debug : virEventPollDispatchHandles:482 : i=5 w=6
>2014-07-16 02:17:32.147+0000: 4378: debug : virEventPollDispatchHandles:482 : i=7 w=8
>2014-07-16 02:17:32.147+0000: 4378: debug : virEventPollDispatchHandles:482 : i=8 w=9
>2014-07-16 02:17:32.147+0000: 4378: debug : virEventPollDispatchHandles:482 : i=9 w=36
>2014-07-16 02:17:32.147+0000: 4378: debug : virEventPollCleanupTimeouts:514 : Cleanup 1
>2014-07-16 02:17:32.148+0000: 4378: debug : virEventPollCleanupTimeouts:527 : EVENT_POLL_PURGE_TIMEOUT: timer=3
>2014-07-16 02:17:32.148+0000: 4378: debug : virEventPollCleanupTimeouts:550 : Found 0 out of 10 timeout slots used, releasing 10
>2014-07-16 02:17:32.148+0000: 4378: debug : virEventPollCleanupHandles:562 : Cleanup 10
>2014-07-16 02:17:32.148+0000: 4378: debug : virHookCheck:119 : No hook script /etc/libvirt/hooks/daemon
>2014-07-16 02:17:32.148+0000: 4378: debug : virHookCheck:119 : No hook script /etc/libvirt/hooks/qemu
>2014-07-16 02:17:32.148+0000: 4378: debug : virHookCheck:119 : No hook script /etc/libvirt/hooks/lxc
>2014-07-16 02:17:32.148+0000: 4378: info : virNetlinkEventServiceStopAll:421 : stopping all netlink event services
>2014-07-16 02:17:32.148+0000: 4378: debug : virEventPollRemoveHandle:180 : EVENT_POLL_REMOVE_HANDLE: watch=5
>2014-07-16 02:17:32.148+0000: 4378: debug : virEventPollRemoveHandle:193 : mark delete 4 14
>2014-07-16 02:17:32.148+0000: 4378: debug : virEventPollInterruptLocked:710 : Skip interrupt, 0 140008766417024
>2014-07-16 02:17:32.148+0000: 4378: debug : virEventPollRemoveHandle:180 : EVENT_POLL_REMOVE_HANDLE: watch=6
>2014-07-16 02:17:32.148+0000: 4378: debug : virEventPollRemoveHandle:193 : mark delete 5 13
>2014-07-16 02:17:32.148+0000: 4378: debug : virEventPollInterruptLocked:710 : Skip interrupt, 0 140008766417024
>2014-07-16 02:17:32.148+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5656b2f100
>2014-07-16 02:17:32.148+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5656b2f090
>2014-07-16 02:17:32.148+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5656b30500
>2014-07-16 02:17:32.148+0000: 4378: debug : virFileClose:90 : Closed fd 11
>2014-07-16 02:17:32.148+0000: 4378: debug : virFileClose:90 : Closed fd 12
>2014-07-16 02:17:32.148+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5656b24720
>2014-07-16 02:17:32.148+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f5656b24720
>2014-07-16 02:17:32.148+0000: 4378: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=3 events=0
>2014-07-16 02:17:32.148+0000: 4378: debug : virEventPollInterruptLocked:710 : Skip interrupt, 0 140008766417024
>2014-07-16 02:17:32.148+0000: 4378: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=4 events=0
>2014-07-16 02:17:32.148+0000: 4378: debug : virEventPollInterruptLocked:710 : Skip interrupt, 0 140008766417024
>2014-07-16 02:17:32.148+0000: 4378: debug : virFileClose:90 : Closed fd 8
>2014-07-16 02:17:32.148+0000: 4378: debug : virFileClose:90 : Closed fd 9
>2014-07-16 02:17:32.148+0000: 4378: debug : virEventPollRemoveHandle:180 : EVENT_POLL_REMOVE_HANDLE: watch=2
>2014-07-16 02:17:32.148+0000: 4378: debug : virEventPollRemoveHandle:193 : mark delete 1 8
>2014-07-16 02:17:32.148+0000: 4378: debug : virEventPollInterruptLocked:710 : Skip interrupt, 0 140008766417024
>2014-07-16 02:17:32.148+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5656b30490
>2014-07-16 02:17:32.148+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5656b30b50
>2014-07-16 02:17:32.149+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5656b2f100
>2014-07-16 02:17:32.149+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f5656b2f100
>2014-07-16 02:17:32.149+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5656b2f090
>2014-07-16 02:17:32.149+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f5656b2f090
>2014-07-16 02:17:32.149+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5656b30500
>2014-07-16 02:17:32.149+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f5656b30500
>2014-07-16 02:17:32.149+0000: 4378: debug : virFileClose:90 : Closed fd 5
>2014-07-16 02:17:32.149+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f56340008c0
>2014-07-16 02:17:32.149+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f56340008c0
>2014-07-16 02:17:32.149+0000: 4378: debug : virEventPollRemoveHandle:180 : EVENT_POLL_REMOVE_HANDLE: watch=9
>2014-07-16 02:17:32.149+0000: 4378: debug : virEventPollRemoveHandle:193 : mark delete 8 17
>2014-07-16 02:17:32.149+0000: 4378: debug : virEventPollInterruptLocked:710 : Skip interrupt, 0 140008766417024
>2014-07-16 02:17:32.149+0000: 4378: debug : virFileClose:90 : Closed fd 18
>2014-07-16 02:17:32.149+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f56340109b0
>2014-07-16 02:17:32.149+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f56340109b0
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5634152910
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f5634152910
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f56341a5970
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f56341a5970
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f56341a5b10
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f56341a5b10
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f56341a5aa0
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f56341a5aa0
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f56341a5dc0
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f56341a5dc0
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f56341a5ff0
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f56341a5ff0
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f56341c01d0
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f56341c01d0
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f56341be6a0
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f56341be6a0
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f56341bd070
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f56341bd070
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f56342061e0
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f56342061e0
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5634206f50
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f5634206f50
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f56342069d0
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f56342069d0
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5634205f70
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f5634205f70
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5634205020
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f5634205020
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f56341bcb20
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f56341bcb20
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f56341c0900
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f56341c0900
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f56341bf420
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f56341bf420
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f56341b7eb0
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f56341b7eb0
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5634206d70
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f5634206d70
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5634206890
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f5634206890
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f56342052b0
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f56342052b0
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f56341bdf20
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f56341bdf20
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f56341be010
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f56341be010
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f56341b44b0
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f56341b44b0
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f56342051f0
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f56342051f0
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5634205150
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f5634205150
>2014-07-16 02:17:32.151+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5634206580
>2014-07-16 02:17:32.152+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f5634206580
>2014-07-16 02:17:32.152+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f56341bd760
>2014-07-16 02:17:32.152+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f56341bd760
>2014-07-16 02:17:32.152+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f56341b2a00
>2014-07-16 02:17:32.152+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f56341b2a00
>2014-07-16 02:17:32.152+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5634206760
>2014-07-16 02:17:32.152+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f5634206760
>2014-07-16 02:17:32.152+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f56342059f0
>2014-07-16 02:17:32.152+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f56342059f0
>2014-07-16 02:17:32.152+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f563414e6e0
>2014-07-16 02:17:32.152+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f563414e6e0
>2014-07-16 02:17:32.152+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f561c0030f0
>2014-07-16 02:17:32.152+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5634157260
>2014-07-16 02:17:32.152+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f5634157260
>2014-07-16 02:17:32.152+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f56341572d0
>2014-07-16 02:17:32.152+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f56341572d0
>2014-07-16 02:17:32.152+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5634156d30
>2014-07-16 02:17:32.152+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f5634156d30
>2014-07-16 02:17:32.152+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f56341c0da0
>2014-07-16 02:17:32.152+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f56341c0da0
>2014-07-16 02:17:32.152+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f56341c1ff0
>2014-07-16 02:17:32.152+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f56341c1ff0
>2014-07-16 02:17:32.152+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f56341a5910
>2014-07-16 02:17:32.152+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f56341a5910
>2014-07-16 02:17:32.152+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5634156090
>2014-07-16 02:17:32.152+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f5634156090
>2014-07-16 02:17:32.153+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f56341a5c80
>2014-07-16 02:17:32.153+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f56341a5c80
>2014-07-16 02:17:32.153+0000: 4378: debug : virLockManagerNopDeinit:42 :  
>2014-07-16 02:17:32.153+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f56341c0020
>2014-07-16 02:17:32.153+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f56341c0020
>2014-07-16 02:17:32.153+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5634207770
>2014-07-16 02:17:32.153+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f5634207770
>2014-07-16 02:17:32.153+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5634207150
>2014-07-16 02:17:32.153+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f5634207150
>2014-07-16 02:17:32.153+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5634207280
>2014-07-16 02:17:32.153+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f56341c2870
>2014-07-16 02:17:32.153+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f56341c2870
>2014-07-16 02:17:32.156+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f5634207810
>2014-07-16 02:17:32.156+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f5634207810
>2014-07-16 02:17:32.156+0000: 4378: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7f56341c2350
>2014-07-16 02:17:32.156+0000: 4378: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7f56341c2350

Actions: View

Attachments on bug 924853: 918142 | 918143 | 918284 | 918285