Attachment 702714 Details for Bug 915636 – libvirtd crash log

libvirtd crash log

libvirtd.log (text/plain), 134.53 KB, created by zhpeng on 2013-02-26 09:12:36 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: zhpeng

Created: 2013-02-26 09:12:36 UTC

Size: 134.53 KB

patch

obsolete

>2013-02-26 06:33:16.155+0000: 2470: info : libvirt version: 0.10.2, package: 18.el6 (Red Hat, Inc. <http://bugzilla.redhat.com/bugzilla>, 2013-01-28-15:42:10, x86-003.build.bos.redhat.com)
>2013-02-26 06:33:16.155+0000: 2470: warning : virCgroupMoveTask:885 : no vm cgroup in controller 3
>2013-02-26 06:33:16.155+0000: 2470: warning : virCgroupMoveTask:885 : no vm cgroup in controller 4
>2013-02-26 06:33:16.155+0000: 2470: warning : virCgroupMoveTask:885 : no vm cgroup in controller 6
>2013-02-26 07:45:07.006+0000: 2466: error : qemuMonitorIO:613 : internal error End of file from monitor
>2013-02-26 07:46:08.405+0000: 2471: warning : virCgroupMoveTask:885 : no vm cgroup in controller 3
>2013-02-26 07:46:08.405+0000: 2471: warning : virCgroupMoveTask:885 : no vm cgroup in controller 4
>2013-02-26 07:46:08.405+0000: 2471: warning : virCgroupMoveTask:885 : no vm cgroup in controller 6
>2013-02-26 07:53:41.256+0000: 2466: warning : qemuAgentNotifyEvent:1274 : Received unexpected event 3
>2013-02-26 08:11:21.283+0000: 2466: error : qemuMonitorIO:613 : internal error End of file from monitor
>2013-02-26 08:11:28.234+0000: 2470: warning : virCgroupMoveTask:885 : no vm cgroup in controller 3
>2013-02-26 08:11:28.234+0000: 2470: warning : virCgroupMoveTask:885 : no vm cgroup in controller 4
>2013-02-26 08:11:28.234+0000: 2470: warning : virCgroupMoveTask:885 : no vm cgroup in controller 6
>2013-02-26 08:13:59.975+0000: 2466: error : qemuMonitorIO:613 : internal error End of file from monitor
>2013-02-26 08:14:04.352+0000: 2470: warning : virCgroupMoveTask:885 : no vm cgroup in controller 3
>2013-02-26 08:14:04.352+0000: 2470: warning : virCgroupMoveTask:885 : no vm cgroup in controller 4
>2013-02-26 08:14:04.352+0000: 2470: warning : virCgroupMoveTask:885 : no vm cgroup in controller 6
>2013-02-26 08:19:36.349+0000: 2466: warning : qemuAgentNotifyEvent:1274 : Received unexpected event 1
>2013-02-26 08:19:36.356+0000: 2466: error : qemuMonitorIO:613 : internal error End of file from monitor
>2013-02-26 08:19:36.356+0000: 2466: error : qemuAgentIO:642 : internal error End of file from monitor
>2013-02-26 08:19:36.358+0000: 2467: warning : virEventPollUpdateHandle:149 : Ignoring invalid update watch 0
>2013-02-26 08:19:36.997+0000: 2470: error : virProcessInfoGetAffinity:137 : cannot get CPU affinity of process 12818: No such process
>2013-02-26 08:20:06.000+0000: 2472: warning : qemuDomainObjBeginJobInternal:839 : Cannot start job (destroy, none) for domain aaa; current job is (modify, none) owned by (2467, 0)
>2013-02-26 08:20:06.000+0000: 2472: error : qemuDomainObjBeginJobInternal:843 : Timed out during operation: cannot acquire state change lock
>2013-02-26 08:20:17.206+0000: 2466: error : virNetSocketReadWire:1184 : End of file while reading data: Input/output error
>2013-02-26 08:20:41.826+0000: 13585: info : libvirt version: 0.10.2, package: 18.el6 (Red Hat, Inc. <http://bugzilla.redhat.com/bugzilla>, 2013-01-28-15:42:10, x86-003.build.bos.redhat.com)
>2013-02-26 08:20:41.826+0000: 13585: error : qemuMonitorOpenUnix:292 : failed to connect to monitor socket: æ²¡æé£ä¸ªè¿ç¨
>2013-02-26 08:20:57.868+0000: 13717: info : libvirt version: 0.10.2, package: 18.el6 (Red Hat, Inc. <http://bugzilla.redhat.com/bugzilla>, 2013-01-28-15:42:10, x86-003.build.bos.redhat.com)
>2013-02-26 08:20:57.868+0000: 13717: warning : virCgroupMoveTask:885 : no vm cgroup in controller 3
>2013-02-26 08:20:57.868+0000: 13717: warning : virCgroupMoveTask:885 : no vm cgroup in controller 4
>2013-02-26 08:20:57.868+0000: 13717: warning : virCgroupMoveTask:885 : no vm cgroup in controller 6
>2013-02-26 08:31:12.610+0000: 13715: warning : qemuAgentNotifyEvent:1274 : Received unexpected event 1
>2013-02-26 08:31:12.616+0000: 13715: error : qemuMonitorIO:613 : åé¨éè¯¯ End of file from monitor
>2013-02-26 08:31:12.616+0000: 13715: error : qemuAgentIO:642 : åé¨éè¯¯ End of file from monitor
>2013-02-26 08:31:29.147+0000: 13715: error : virNetSocketReadWire:1184 : End of file while reading data: è¾å¥/è¾åºéè¯¯
>2013-02-26 08:41:13.693+0000: 15581: info : libvirt version: 0.10.2, package: 18.el6 (Red Hat, Inc. <http://bugzilla.redhat.com/bugzilla>, 2013-01-28-15:42:10, x86-003.build.bos.redhat.com)
>2013-02-26 08:41:13.693+0000: 15581: warning : virCgroupMoveTask:885 : no vm cgroup in controller 3
>2013-02-26 08:41:13.693+0000: 15581: warning : virCgroupMoveTask:885 : no vm cgroup in controller 4
>2013-02-26 08:41:13.693+0000: 15581: warning : virCgroupMoveTask:885 : no vm cgroup in controller 6
>2013-02-26 08:43:09.184+0000: 15579: warning : qemuAgentNotifyEvent:1274 : Received unexpected event 1
>2013-02-26 08:43:09.184+0000: 15579: error : qemuMonitorIO:613 : åé¨éè¯¯ End of file from monitor
>2013-02-26 08:43:09.184+0000: 15579: error : qemuAgentIO:642 : åé¨éè¯¯ End of file from monitor
>Caught Segmentation violation dumping internal log buffer:
>
>
>    ====== start of log =====
>
>000015579: debug : virEventPollCalculateTimeout:346 : Timeout at 1361868189316 due in 381 ms
>2013-02-26 08:43:08.935+000015579: debug : virEventPollRunOnce:614 : EVENT_POLL_RUN: nhandles=13 timeout=381
>2013-02-26 08:43:08.935+000015579: debug : virEventPollRunOnce:625 : Poll got 1 event(s)
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchTimeouts:410 : Dispatch 9
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchHandles:455 : Dispatch 13
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchHandles:469 : i=0 w=1
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchHandles:469 : i=1 w=2
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchHandles:469 : i=2 w=3
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchHandles:469 : i=3 w=4
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchHandles:469 : i=4 w=5
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchHandles:469 : i=5 w=6
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchHandles:469 : i=6 w=7
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchHandles:469 : i=7 w=8
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchHandles:469 : i=8 w=9
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchHandles:469 : i=9 w=10
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchHandles:469 : i=10 w=11
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchHandles:469 : i=11 w=12
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchHandles:469 : i=12 w=13
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchHandles:483 : EVENT_POLL_DISPATCH_HANDLE: watch=13 events=2
>2013-02-26 08:43:08.935+000015579: debug : virNetMessageFree:73 : msg=0x1d81770 nfds=0 cb=(nil)
>2013-02-26 08:43:08.935+000015579: debug : virNetServerClientCalculateHandleMode:152 : tls=(nil) hs=-1, rx=0x1d83910 tx=(nil)
>2013-02-26 08:43:08.935+000015579: debug : virNetServerClientCalculateHandleMode:183 : mode=1
>2013-02-26 08:43:08.935+000015579: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=13 events=1
>2013-02-26 08:43:08.935+000015579: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 106215520
>2013-02-26 08:43:08.935+000015579: debug : virEventPollCleanupTimeouts:501 : Cleanup 9
>2013-02-26 08:43:08.935+000015579: debug : virEventPollCleanupHandles:549 : Cleanup 13
>2013-02-26 08:43:08.935+000015579: debug : virEventRunDefaultImpl:244 : running default event implementation
>2013-02-26 08:43:08.935+000015579: debug : virEventPollCleanupTimeouts:501 : Cleanup 9
>2013-02-26 08:43:08.935+000015579: debug : virEventPollCleanupHandles:549 : Cleanup 13
>2013-02-26 08:43:08.935+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=0 w=1, f=7 e=1 d=0
>2013-02-26 08:43:08.935+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=1 w=2, f=9 e=1 d=0
>2013-02-26 08:43:08.935+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=2 w=3, f=12 e=1 d=0
>2013-02-26 08:43:08.935+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=3 w=4, f=13 e=1 d=0
>2013-02-26 08:43:08.935+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=4 w=5, f=6 e=1 d=0
>2013-02-26 08:43:08.935+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=5 w=6, f=16 e=1 d=0
>2013-02-26 08:43:08.935+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=6 w=7, f=17 e=1 d=0
>2013-02-26 08:43:08.935+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=7 w=8, f=19 e=1 d=0
>2013-02-26 08:43:08.935+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=8 w=9, f=24 e=25 d=0
>2013-02-26 08:43:08.935+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=9 w=10, f=23 e=25 d=0
>2013-02-26 08:43:08.935+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=10 w=11, f=22 e=1 d=0
>2013-02-26 08:43:08.935+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=11 w=12, f=27 e=1 d=0
>2013-02-26 08:43:08.935+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=12 w=13, f=30 e=1 d=0
>2013-02-26 08:43:08.935+000015579: debug : virEventPollCalculateTimeout:320 : Calculate expiry of 9 timers
>2013-02-26 08:43:08.935+000015579: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361868189316
>2013-02-26 08:43:08.935+000015579: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361868191317
>2013-02-26 08:43:08.935+000015579: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361868191017
>2013-02-26 08:43:08.935+000015579: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361868191928
>2013-02-26 08:43:08.935+000015579: debug : virEventPollCalculateTimeout:346 : Timeout at 1361868189316 due in 381 ms
>2013-02-26 08:43:08.935+000015579: debug : virEventPollRunOnce:614 : EVENT_POLL_RUN: nhandles=13 timeout=381
>2013-02-26 08:43:08.935+000015579: debug : virEventPollRunOnce:625 : Poll got 1 event(s)
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchTimeouts:410 : Dispatch 9
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchHandles:455 : Dispatch 13
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchHandles:469 : i=0 w=1
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchHandles:469 : i=1 w=2
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchHandles:469 : i=2 w=3
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchHandles:469 : i=3 w=4
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchHandles:469 : i=4 w=5
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchHandles:469 : i=5 w=6
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchHandles:469 : i=6 w=7
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchHandles:469 : i=7 w=8
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchHandles:469 : i=8 w=9
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchHandles:469 : i=9 w=10
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchHandles:469 : i=10 w=11
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchHandles:469 : i=11 w=12
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchHandles:469 : i=12 w=13
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchHandles:483 : EVENT_POLL_DISPATCH_HANDLE: watch=13 events=1
>2013-02-26 08:43:08.935+000015579: debug : virNetMessageDecodeLength:152 : Got length, now need 28 total (24 more)
>2013-02-26 08:43:08.935+000015579: debug : virNetServerClientCalculateHandleMode:152 : tls=(nil) hs=-1, rx=0x1d83910 tx=(nil)
>2013-02-26 08:43:08.935+000015579: debug : virNetServerClientCalculateHandleMode:183 : mode=1
>2013-02-26 08:43:08.935+000015579: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=13 events=1
>2013-02-26 08:43:08.935+000015579: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 106215520
>2013-02-26 08:43:08.935+000015579: debug : virNetServerClientDispatchRead:875 : RPC_SERVER_CLIENT_MSG_RX: client=0x1d83a60 len=28 prog=536903814 vers=1 proc=110 type=0 status=0 serial=3
>2013-02-26 08:43:08.935+000015579: debug : virKeepAliveCheckMessage:384 : ka=0x1d83070, client=0x1d83a60, msg=0x1d83910
>2013-02-26 08:43:08.935+000015579: debug : virEventPollUpdateTimeout:254 : EVENT_POLL_UPDATE_TIMEOUT: timer=9 frequency=3000
>2013-02-26 08:43:08.935+000015579: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 106215520
>2013-02-26 08:43:08.935+000015579: debug : virObjectRef:168 : OBJECT_REF: obj=0x1d83a60
>2013-02-26 08:43:08.935+000015579: debug : virNetServerDispatchNewMessage:218 : server=0x1d7ad50 client=0x1d83a60 message=0x1d83910
>2013-02-26 08:43:08.935+000015579: debug : virObjectRef:168 : OBJECT_REF: obj=0x1d85f70
>2013-02-26 08:43:08.935+000015579: debug : virNetMessageNew:45 : msg=0x1d81770 tracked=1
>2013-02-26 08:43:08.935+000015579: debug : virNetServerClientCalculateHandleMode:152 : tls=(nil) hs=-1, rx=0x1d81770 tx=(nil)
>2013-02-26 08:43:08.935+000015579: debug : virNetServerClientCalculateHandleMode:183 : mode=1
>2013-02-26 08:43:08.935+000015579: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=13 events=1
>2013-02-26 08:43:08.935+000015579: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 106215520
>2013-02-26 08:43:08.935+000015579: debug : virEventPollCleanupTimeouts:501 : Cleanup 9
>2013-02-26 08:43:08.935+000015579: debug : virEventPollCleanupHandles:549 : Cleanup 13
>2013-02-26 08:43:08.935+000015579: debug : virEventRunDefaultImpl:244 : running default event implementation
>2013-02-26 08:43:08.935+000015579: debug : virEventPollCleanupTimeouts:501 : Cleanup 9
>2013-02-26 08:43:08.935+000015579: debug : virEventPollCleanupHandles:549 : Cleanup 13
>2013-02-26 08:43:08.935+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=0 w=1, f=7 e=1 d=0
>2013-02-26 08:43:08.935+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=1 w=2, f=9 e=1 d=0
>2013-02-26 08:43:08.935+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=2 w=3, f=12 e=1 d=0
>2013-02-26 08:43:08.935+000015585: debug : virNetServerHandleJob:189 : server=0x1d7ad50 client=0x1d83a60 message=0x1d83910 prog=0x1d85f70
>2013-02-26 08:43:08.935+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=3 w=4, f=13 e=1 d=0
>2013-02-26 08:43:08.935+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=4 w=5, f=6 e=1 d=0
>2013-02-26 08:43:08.935+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=5 w=6, f=16 e=1 d=0
>2013-02-26 08:43:08.935+000015585: debug : virNetServerProgramDispatch:284 : prog=536903814 ver=1 type=0 status=0 serial=3 proc=110
>2013-02-26 08:43:08.935+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=6 w=7, f=17 e=1 d=0
>2013-02-26 08:43:08.935+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=7 w=8, f=19 e=1 d=0
>2013-02-26 08:43:08.935+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=8 w=9, f=24 e=25 d=0
>2013-02-26 08:43:08.935+000015585: debug : remoteDispatchGetURIHelper:7297 : server=0x1d7ad50 client=0x1d83a60 msg=0x1d83910 rerr=0x7f7afd4b3b80 args=0x7f7adc000aa0 ret=0x7f7adc000ac0
>2013-02-26 08:43:08.935+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=9 w=10, f=23 e=25 d=0
>2013-02-26 08:43:08.935+000015585: debug : virConnectGetURI:1700 : conn=0x7f7af41192f0
>2013-02-26 08:43:08.935+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=10 w=11, f=22 e=1 d=0
>2013-02-26 08:43:08.935+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=11 w=12, f=27 e=1 d=0
>2013-02-26 08:43:08.935+000015585: debug : virNetMessageEncodePayload:358 : Encode length as 48
>2013-02-26 08:43:08.935+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=12 w=13, f=30 e=1 d=0
>2013-02-26 08:43:08.935+000015579: debug : virEventPollCalculateTimeout:320 : Calculate expiry of 9 timers
>2013-02-26 08:43:08.935+000015585: debug : virNetServerClientSendMessageLocked:1119 : msg=0x1d83910 proc=110 len=48 offset=0
>2013-02-26 08:43:08.935+000015579: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361868189316
>2013-02-26 08:43:08.935+000015579: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361868191317
>2013-02-26 08:43:08.935+000015585: debug : virNetServerClientSendMessageLocked:1127 : RPC_SERVER_CLIENT_MSG_TX_QUEUE: client=0x1d83a60 len=48 prog=536903814 vers=1 proc=110 type=1 status=0 serial=3
>2013-02-26 08:43:08.935+000015579: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361868191017
>2013-02-26 08:43:08.935+000015579: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361868191935
>2013-02-26 08:43:08.935+000015585: debug : virNetServerClientCalculateHandleMode:152 : tls=(nil) hs=-1, rx=0x1d81770 tx=0x1d83910
>2013-02-26 08:43:08.935+000015579: debug : virEventPollCalculateTimeout:346 : Timeout at 1361868189316 due in 381 ms
>2013-02-26 08:43:08.935+000015585: debug : virNetServerClientCalculateHandleMode:183 : mode=3
>2013-02-26 08:43:08.935+000015579: debug : virEventPollRunOnce:614 : EVENT_POLL_RUN: nhandles=13 timeout=381
>2013-02-26 08:43:08.935+000015585: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=13 events=3
>2013-02-26 08:43:08.935+000015585: debug : virEventPollInterruptLocked:701 : Interrupting
>2013-02-26 08:43:08.935+000015585: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x1d85f70
>2013-02-26 08:43:08.935+000015585: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x1d83a60
>2013-02-26 08:43:08.935+000015579: debug : virEventPollRunOnce:625 : Poll got 1 event(s)
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchTimeouts:410 : Dispatch 9
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchHandles:455 : Dispatch 13
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchHandles:469 : i=0 w=1
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchHandles:483 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchHandles:469 : i=1 w=2
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchHandles:469 : i=2 w=3
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchHandles:469 : i=3 w=4
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchHandles:469 : i=4 w=5
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchHandles:469 : i=5 w=6
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchHandles:469 : i=6 w=7
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchHandles:469 : i=7 w=8
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchHandles:469 : i=8 w=9
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchHandles:469 : i=9 w=10
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchHandles:469 : i=10 w=11
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchHandles:469 : i=11 w=12
>2013-02-26 08:43:08.935+000015579: debug : virEventPollDispatchHandles:469 : i=12 w=13
>2013-02-26 08:43:08.935+000015579: debug : virEventPollCleanupTimeouts:501 : Cleanup 9
>2013-02-26 08:43:08.935+000015579: debug : virEventPollCleanupHandles:549 : Cleanup 13
>2013-02-26 08:43:08.935+000015579: debug : virEventRunDefaultImpl:244 : running default event implementation
>2013-02-26 08:43:08.935+000015579: debug : virEventPollCleanupTimeouts:501 : Cleanup 9
>2013-02-26 08:43:08.936+000015579: debug : virEventPollCleanupHandles:549 : Cleanup 13
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=0 w=1, f=7 e=1 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=1 w=2, f=9 e=1 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=2 w=3, f=12 e=1 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=3 w=4, f=13 e=1 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=4 w=5, f=6 e=1 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=5 w=6, f=16 e=1 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=6 w=7, f=17 e=1 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=7 w=8, f=19 e=1 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=8 w=9, f=24 e=25 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=9 w=10, f=23 e=25 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=10 w=11, f=22 e=1 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=11 w=12, f=27 e=1 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=12 w=13, f=30 e=5 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollCalculateTimeout:320 : Calculate expiry of 9 timers
>2013-02-26 08:43:08.936+000015579: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361868189316
>2013-02-26 08:43:08.936+000015579: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361868191317
>2013-02-26 08:43:08.936+000015579: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361868191017
>2013-02-26 08:43:08.936+000015579: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361868191935
>2013-02-26 08:43:08.936+000015579: debug : virEventPollCalculateTimeout:346 : Timeout at 1361868189316 due in 380 ms
>2013-02-26 08:43:08.936+000015579: debug : virEventPollRunOnce:614 : EVENT_POLL_RUN: nhandles=13 timeout=380
>2013-02-26 08:43:08.936+000015579: debug : virEventPollRunOnce:625 : Poll got 1 event(s)
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchTimeouts:410 : Dispatch 9
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:455 : Dispatch 13
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=0 w=1
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=1 w=2
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=2 w=3
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=3 w=4
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=4 w=5
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=5 w=6
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=6 w=7
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=7 w=8
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=8 w=9
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=9 w=10
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=10 w=11
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=11 w=12
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=12 w=13
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:483 : EVENT_POLL_DISPATCH_HANDLE: watch=13 events=2
>2013-02-26 08:43:08.936+000015579: debug : virNetMessageFree:73 : msg=0x1d83910 nfds=0 cb=(nil)
>2013-02-26 08:43:08.936+000015579: debug : virNetServerClientCalculateHandleMode:152 : tls=(nil) hs=-1, rx=0x1d81770 tx=(nil)
>2013-02-26 08:43:08.936+000015579: debug : virNetServerClientCalculateHandleMode:183 : mode=1
>2013-02-26 08:43:08.936+000015579: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=13 events=1
>2013-02-26 08:43:08.936+000015579: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 106215520
>2013-02-26 08:43:08.936+000015579: debug : virEventPollCleanupTimeouts:501 : Cleanup 9
>2013-02-26 08:43:08.936+000015579: debug : virEventPollCleanupHandles:549 : Cleanup 13
>2013-02-26 08:43:08.936+000015579: debug : virEventRunDefaultImpl:244 : running default event implementation
>2013-02-26 08:43:08.936+000015579: debug : virEventPollCleanupTimeouts:501 : Cleanup 9
>2013-02-26 08:43:08.936+000015579: debug : virEventPollCleanupHandles:549 : Cleanup 13
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=0 w=1, f=7 e=1 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=1 w=2, f=9 e=1 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=2 w=3, f=12 e=1 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=3 w=4, f=13 e=1 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=4 w=5, f=6 e=1 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=5 w=6, f=16 e=1 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=6 w=7, f=17 e=1 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=7 w=8, f=19 e=1 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=8 w=9, f=24 e=25 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=9 w=10, f=23 e=25 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=10 w=11, f=22 e=1 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=11 w=12, f=27 e=1 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=12 w=13, f=30 e=1 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollCalculateTimeout:320 : Calculate expiry of 9 timers
>2013-02-26 08:43:08.936+000015579: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361868189316
>2013-02-26 08:43:08.936+000015579: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361868191317
>2013-02-26 08:43:08.936+000015579: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361868191017
>2013-02-26 08:43:08.936+000015579: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361868191935
>2013-02-26 08:43:08.936+000015579: debug : virEventPollCalculateTimeout:346 : Timeout at 1361868189316 due in 380 ms
>2013-02-26 08:43:08.936+000015579: debug : virEventPollRunOnce:614 : EVENT_POLL_RUN: nhandles=13 timeout=380
>2013-02-26 08:43:08.936+000015579: debug : virEventPollRunOnce:625 : Poll got 1 event(s)
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchTimeouts:410 : Dispatch 9
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:455 : Dispatch 13
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=0 w=1
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=1 w=2
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=2 w=3
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=3 w=4
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=4 w=5
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=5 w=6
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=6 w=7
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=7 w=8
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=8 w=9
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=9 w=10
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=10 w=11
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=11 w=12
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=12 w=13
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:483 : EVENT_POLL_DISPATCH_HANDLE: watch=13 events=1
>2013-02-26 08:43:08.936+000015579: debug : virNetMessageDecodeLength:152 : Got length, now need 36 total (32 more)
>2013-02-26 08:43:08.936+000015579: debug : virNetServerClientCalculateHandleMode:152 : tls=(nil) hs=-1, rx=0x1d81770 tx=(nil)
>2013-02-26 08:43:08.936+000015579: debug : virNetServerClientCalculateHandleMode:183 : mode=1
>2013-02-26 08:43:08.936+000015579: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=13 events=1
>2013-02-26 08:43:08.936+000015579: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 106215520
>2013-02-26 08:43:08.936+000015579: debug : virNetServerClientDispatchRead:875 : RPC_SERVER_CLIENT_MSG_RX: client=0x1d83a60 len=36 prog=536903814 vers=1 proc=23 type=0 status=0 serial=4
>2013-02-26 08:43:08.936+000015579: debug : virKeepAliveCheckMessage:384 : ka=0x1d83070, client=0x1d83a60, msg=0x1d81770
>2013-02-26 08:43:08.936+000015579: debug : virEventPollUpdateTimeout:254 : EVENT_POLL_UPDATE_TIMEOUT: timer=9 frequency=3000
>2013-02-26 08:43:08.936+000015579: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 106215520
>2013-02-26 08:43:08.936+000015579: debug : virObjectRef:168 : OBJECT_REF: obj=0x1d83a60
>2013-02-26 08:43:08.936+000015579: debug : virNetServerDispatchNewMessage:218 : server=0x1d7ad50 client=0x1d83a60 message=0x1d81770
>2013-02-26 08:43:08.936+000015579: debug : virObjectRef:168 : OBJECT_REF: obj=0x1d85f70
>2013-02-26 08:43:08.936+000015579: debug : virNetMessageNew:45 : msg=0x1d83910 tracked=1
>2013-02-26 08:43:08.936+000015579: debug : virNetServerClientCalculateHandleMode:152 : tls=(nil) hs=-1, rx=0x1d83910 tx=(nil)
>2013-02-26 08:43:08.936+000015579: debug : virNetServerClientCalculateHandleMode:183 : mode=1
>2013-02-26 08:43:08.936+000015579: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=13 events=1
>2013-02-26 08:43:08.936+000015579: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 106215520
>2013-02-26 08:43:08.936+000015583: debug : virNetServerHandleJob:189 : server=0x1d7ad50 client=0x1d83a60 message=0x1d81770 prog=0x1d85f70
>2013-02-26 08:43:08.936+000015579: debug : virEventPollCleanupTimeouts:501 : Cleanup 9
>2013-02-26 08:43:08.936+000015579: debug : virEventPollCleanupHandles:549 : Cleanup 13
>2013-02-26 08:43:08.936+000015583: debug : virNetServerProgramDispatch:284 : prog=536903814 ver=1 type=0 status=0 serial=4 proc=23
>2013-02-26 08:43:08.936+000015579: debug : virEventRunDefaultImpl:244 : running default event implementation
>2013-02-26 08:43:08.936+000015579: debug : virEventPollCleanupTimeouts:501 : Cleanup 9
>2013-02-26 08:43:08.936+000015583: debug : remoteDispatchDomainLookupByNameHelper:3084 : server=0x1d7ad50 client=0x1d83a60 msg=0x1d81770 rerr=0x7f7afe8b5b80 args=0x7f7ad4000bf0 ret=0x7f7ad4000aa0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollCleanupHandles:549 : Cleanup 13
>2013-02-26 08:43:08.936+000015583: debug : virDomainLookupByName:2117 : conn=0x7f7af41192f0, name=aaa
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=0 w=1, f=7 e=1 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=1 w=2, f=9 e=1 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=2 w=3, f=12 e=1 d=0
>2013-02-26 08:43:08.936+000015583: debug : virObjectNew:110 : OBJECT_NEW: obj=0x7f7ad4000b70 classname=virDomain
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=3 w=4, f=13 e=1 d=0
>2013-02-26 08:43:08.936+000015583: debug : virObjectRef:168 : OBJECT_REF: obj=0x7f7af41192f0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=4 w=5, f=6 e=1 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=5 w=6, f=16 e=1 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=6 w=7, f=17 e=1 d=0
>2013-02-26 08:43:08.936+000015583: debug : virDomainFree:2281 : dom=0x7f7ad4000b70, (VM: name=aaa, uuid=f33d9914-4add-c75f-3502-3cd73ea3b795)
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=7 w=8, f=19 e=1 d=0
>2013-02-26 08:43:08.936+000015583: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7f7ad4000b70
>2013-02-26 08:43:08.936+000015583: debug : virObjectUnref:137 : OBJECT_DISPOSE: obj=0x7f7ad4000b70
>2013-02-26 08:43:08.936+000015583: debug : virDomainDispose:225 : release domain 0x7f7ad4000b70 aaa f33d9914-4add-c75f-3502-3cd73ea3b795
>2013-02-26 08:43:08.936+000015583: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7f7af41192f0
>2013-02-26 08:43:08.936+000015583: debug : virNetMessageEncodePayload:358 : Encode length as 56
>2013-02-26 08:43:08.936+000015583: debug : virNetServerClientSendMessageLocked:1119 : msg=0x1d81770 proc=23 len=56 offset=0
>2013-02-26 08:43:08.936+000015583: debug : virNetServerClientSendMessageLocked:1127 : RPC_SERVER_CLIENT_MSG_TX_QUEUE: client=0x1d83a60 len=56 prog=536903814 vers=1 proc=23 type=1 status=0 serial=4
>2013-02-26 08:43:08.936+000015583: debug : virNetServerClientCalculateHandleMode:152 : tls=(nil) hs=-1, rx=0x1d83910 tx=0x1d81770
>2013-02-26 08:43:08.936+000015583: debug : virNetServerClientCalculateHandleMode:183 : mode=3
>2013-02-26 08:43:08.936+000015583: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=13 events=3
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=8 w=9, f=24 e=25 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=9 w=10, f=23 e=25 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=10 w=11, f=22 e=1 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=11 w=12, f=27 e=1 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=12 w=13, f=30 e=1 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollCalculateTimeout:320 : Calculate expiry of 9 timers
>2013-02-26 08:43:08.936+000015579: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361868189316
>2013-02-26 08:43:08.936+000015579: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361868191317
>2013-02-26 08:43:08.936+000015579: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361868191017
>2013-02-26 08:43:08.936+000015579: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361868191936
>2013-02-26 08:43:08.936+000015579: debug : virEventPollCalculateTimeout:346 : Timeout at 1361868189316 due in 380 ms
>2013-02-26 08:43:08.936+000015579: debug : virEventPollRunOnce:614 : EVENT_POLL_RUN: nhandles=13 timeout=380
>2013-02-26 08:43:08.936+000015583: debug : virEventPollInterruptLocked:701 : Interrupting
>2013-02-26 08:43:08.936+000015583: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x1d85f70
>2013-02-26 08:43:08.936+000015583: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x1d83a60
>2013-02-26 08:43:08.936+000015579: debug : virEventPollRunOnce:625 : Poll got 1 event(s)
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchTimeouts:410 : Dispatch 9
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:455 : Dispatch 13
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=0 w=1
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:483 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=1 w=2
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=2 w=3
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=3 w=4
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=4 w=5
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=5 w=6
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=6 w=7
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=7 w=8
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=8 w=9
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=9 w=10
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=10 w=11
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=11 w=12
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=12 w=13
>2013-02-26 08:43:08.936+000015579: debug : virEventPollCleanupTimeouts:501 : Cleanup 9
>2013-02-26 08:43:08.936+000015579: debug : virEventPollCleanupHandles:549 : Cleanup 13
>2013-02-26 08:43:08.936+000015579: debug : virEventRunDefaultImpl:244 : running default event implementation
>2013-02-26 08:43:08.936+000015579: debug : virEventPollCleanupTimeouts:501 : Cleanup 9
>2013-02-26 08:43:08.936+000015579: debug : virEventPollCleanupHandles:549 : Cleanup 13
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=0 w=1, f=7 e=1 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=1 w=2, f=9 e=1 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=2 w=3, f=12 e=1 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=3 w=4, f=13 e=1 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=4 w=5, f=6 e=1 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=5 w=6, f=16 e=1 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=6 w=7, f=17 e=1 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=7 w=8, f=19 e=1 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=8 w=9, f=24 e=25 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=9 w=10, f=23 e=25 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=10 w=11, f=22 e=1 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=11 w=12, f=27 e=1 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=12 w=13, f=30 e=5 d=0
>2013-02-26 08:43:08.936+000015579: debug : virEventPollCalculateTimeout:320 : Calculate expiry of 9 timers
>2013-02-26 08:43:08.936+000015579: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361868189316
>2013-02-26 08:43:08.936+000015579: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361868191317
>2013-02-26 08:43:08.936+000015579: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361868191017
>2013-02-26 08:43:08.936+000015579: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361868191936
>2013-02-26 08:43:08.936+000015579: debug : virEventPollCalculateTimeout:346 : Timeout at 1361868189316 due in 380 ms
>2013-02-26 08:43:08.936+000015579: debug : virEventPollRunOnce:614 : EVENT_POLL_RUN: nhandles=13 timeout=380
>2013-02-26 08:43:08.936+000015579: debug : virEventPollRunOnce:625 : Poll got 1 event(s)
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchTimeouts:410 : Dispatch 9
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:455 : Dispatch 13
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=0 w=1
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=1 w=2
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=2 w=3
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=3 w=4
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=4 w=5
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=5 w=6
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=6 w=7
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=7 w=8
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=8 w=9
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=9 w=10
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=10 w=11
>2013-02-26 08:43:08.936+000015579: debug : virEventPollDispatchHandles:469 : i=11 w=12
>2013-02-26 08:43:08.937+000015579: debug : virEventPollDispatchHandles:469 : i=12 w=13
>2013-02-26 08:43:08.937+000015579: debug : virEventPollDispatchHandles:483 : EVENT_POLL_DISPATCH_HANDLE: watch=13 events=2
>2013-02-26 08:43:08.937+000015579: debug : virNetMessageFree:73 : msg=0x1d81770 nfds=0 cb=(nil)
>2013-02-26 08:43:08.937+000015579: debug : virNetServerClientCalculateHandleMode:152 : tls=(nil) hs=-1, rx=0x1d83910 tx=(nil)
>2013-02-26 08:43:08.937+000015579: debug : virNetServerClientCalculateHandleMode:183 : mode=1
>2013-02-26 08:43:08.937+000015579: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=13 events=1
>2013-02-26 08:43:08.937+000015579: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 106215520
>2013-02-26 08:43:08.937+000015579: debug : virEventPollCleanupTimeouts:501 : Cleanup 9
>2013-02-26 08:43:08.937+000015579: debug : virEventPollCleanupHandles:549 : Cleanup 13
>2013-02-26 08:43:08.937+000015579: debug : virEventRunDefaultImpl:244 : running default event implementation
>2013-02-26 08:43:08.937+000015579: debug : virEventPollCleanupTimeouts:501 : Cleanup 9
>2013-02-26 08:43:08.937+000015579: debug : virEventPollCleanupHandles:549 : Cleanup 13
>2013-02-26 08:43:08.937+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=0 w=1, f=7 e=1 d=0
>2013-02-26 08:43:08.937+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=1 w=2, f=9 e=1 d=0
>2013-02-26 08:43:08.937+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=2 w=3, f=12 e=1 d=0
>2013-02-26 08:43:08.937+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=3 w=4, f=13 e=1 d=0
>2013-02-26 08:43:08.937+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=4 w=5, f=6 e=1 d=0
>2013-02-26 08:43:08.937+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=5 w=6, f=16 e=1 d=0
>2013-02-26 08:43:08.937+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=6 w=7, f=17 e=1 d=0
>2013-02-26 08:43:08.937+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=7 w=8, f=19 e=1 d=0
>2013-02-26 08:43:08.937+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=8 w=9, f=24 e=25 d=0
>2013-02-26 08:43:08.937+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=9 w=10, f=23 e=25 d=0
>2013-02-26 08:43:08.937+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=10 w=11, f=22 e=1 d=0
>2013-02-26 08:43:08.937+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=11 w=12, f=27 e=1 d=0
>2013-02-26 08:43:08.937+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=12 w=13, f=30 e=1 d=0
>2013-02-26 08:43:08.937+000015579: debug : virEventPollCalculateTimeout:320 : Calculate expiry of 9 timers
>2013-02-26 08:43:08.937+000015579: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361868189316
>2013-02-26 08:43:08.937+000015579: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361868191317
>2013-02-26 08:43:08.937+000015579: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361868191017
>2013-02-26 08:43:08.937+000015579: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361868191936
>2013-02-26 08:43:08.937+000015579: debug : virEventPollCalculateTimeout:346 : Timeout at 1361868189316 due in 379 ms
>2013-02-26 08:43:08.937+000015579: debug : virEventPollRunOnce:614 : EVENT_POLL_RUN: nhandles=13 timeout=379
>2013-02-26 08:43:08.937+000015579: debug : virEventPollRunOnce:625 : Poll got 1 event(s)
>2013-02-26 08:43:08.937+000015579: debug : virEventPollDispatchTimeouts:410 : Dispatch 9
>2013-02-26 08:43:08.937+000015579: debug : virEventPollDispatchHandles:455 : Dispatch 13
>2013-02-26 08:43:08.937+000015579: debug : virEventPollDispatchHandles:469 : i=0 w=1
>2013-02-26 08:43:08.937+000015579: debug : virEventPollDispatchHandles:469 : i=1 w=2
>2013-02-26 08:43:08.937+000015579: debug : virEventPollDispatchHandles:469 : i=2 w=3
>2013-02-26 08:43:08.937+000015579: debug : virEventPollDispatchHandles:469 : i=3 w=4
>2013-02-26 08:43:08.937+000015579: debug : virEventPollDispatchHandles:469 : i=4 w=5
>2013-02-26 08:43:08.937+000015579: debug : virEventPollDispatchHandles:469 : i=5 w=6
>2013-02-26 08:43:08.937+000015579: debug : virEventPollDispatchHandles:469 : i=6 w=7
>2013-02-26 08:43:08.937+000015579: debug : virEventPollDispatchHandles:469 : i=7 w=8
>2013-02-26 08:43:08.937+000015579: debug : virEventPollDispatchHandles:469 : i=8 w=9
>2013-02-26 08:43:08.937+000015579: debug : virEventPollDispatchHandles:469 : i=9 w=10
>2013-02-26 08:43:08.937+000015579: debug : virEventPollDispatchHandles:469 : i=10 w=11
>2013-02-26 08:43:08.937+000015579: debug : virEventPollDispatchHandles:469 : i=11 w=12
>2013-02-26 08:43:08.937+000015579: debug : virEventPollDispatchHandles:469 : i=12 w=13
>2013-02-26 08:43:08.937+000015579: debug : virEventPollDispatchHandles:483 : EVENT_POLL_DISPATCH_HANDLE: watch=13 events=1
>2013-02-26 08:43:08.937+000015579: debug : virNetMessageDecodeLength:152 : Got length, now need 56 total (52 more)
>2013-02-26 08:43:08.937+000015579: debug : virNetServerClientCalculateHandleMode:152 : tls=(nil) hs=-1, rx=0x1d83910 tx=(nil)
>2013-02-26 08:43:08.937+000015579: debug : virNetServerClientCalculateHandleMode:183 : mode=1
>2013-02-26 08:43:08.937+000015579: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=13 events=1
>2013-02-26 08:43:08.937+000015579: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 106215520
>2013-02-26 08:43:08.937+000015579: debug : virNetServerClientDispatchRead:875 : RPC_SERVER_CLIENT_MSG_RX: client=0x1d83a60 len=56 prog=536903814 vers=1 proc=12 type=0 status=0 serial=5
>2013-02-26 08:43:08.937+000015579: debug : virKeepAliveCheckMessage:384 : ka=0x1d83070, client=0x1d83a60, msg=0x1d83910
>2013-02-26 08:43:08.937+000015579: debug : virEventPollUpdateTimeout:254 : EVENT_POLL_UPDATE_TIMEOUT: timer=9 frequency=3000
>2013-02-26 08:43:08.937+000015579: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 106215520
>2013-02-26 08:43:08.937+000015579: debug : virObjectRef:168 : OBJECT_REF: obj=0x1d83a60
>2013-02-26 08:43:08.937+000015579: debug : virNetServerDispatchNewMessage:218 : server=0x1d7ad50 client=0x1d83a60 message=0x1d83910
>2013-02-26 08:43:08.937+000015579: debug : virObjectRef:168 : OBJECT_REF: obj=0x1d85f70
>2013-02-26 08:43:08.937+000015579: debug : virNetMessageNew:45 : msg=0x1d81770 tracked=1
>2013-02-26 08:43:08.937+000015579: debug : virNetServerClientCalculateHandleMode:152 : tls=(nil) hs=-1, rx=0x1d81770 tx=(nil)
>2013-02-26 08:43:08.937+000015580: debug : virNetServerHandleJob:189 : server=0x1d7ad50 client=0x1d83a60 message=0x1d83910 prog=0x1d85f70
>2013-02-26 08:43:08.937+000015579: debug : virNetServerClientCalculateHandleMode:183 : mode=1
>2013-02-26 08:43:08.937+000015579: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=13 events=1
>2013-02-26 08:43:08.937+000015580: debug : virNetServerProgramDispatch:284 : prog=536903814 ver=1 type=0 status=0 serial=5 proc=12
>2013-02-26 08:43:08.937+000015579: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 106215520
>2013-02-26 08:43:08.937+000015579: debug : virEventPollCleanupTimeouts:501 : Cleanup 9
>2013-02-26 08:43:08.937+000015579: debug : virEventPollCleanupHandles:549 : Cleanup 13
>2013-02-26 08:43:08.937+000015579: debug : virEventRunDefaultImpl:244 : running default event implementation
>2013-02-26 08:43:08.937+000015580: debug : remoteDispatchDomainDestroyHelper:1254 : server=0x1d7ad50 client=0x1d83a60 msg=0x1d83910 rerr=0x7f7b006b8b80 args=0x7f7af4239a20 ret=0x7f7af42399c0
>2013-02-26 08:43:08.937+000015579: debug : virEventPollCleanupTimeouts:501 : Cleanup 9
>2013-02-26 08:43:08.937+000015580: debug : virObjectNew:110 : OBJECT_NEW: obj=0x7f7af42399e0 classname=virDomain
>2013-02-26 08:43:08.937+000015579: debug : virEventPollCleanupHandles:549 : Cleanup 13
>2013-02-26 08:43:08.937+000015580: debug : virObjectRef:168 : OBJECT_REF: obj=0x7f7af41192f0
>2013-02-26 08:43:08.937+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=0 w=1, f=7 e=1 d=0
>2013-02-26 08:43:08.937+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=1 w=2, f=9 e=1 d=0
>2013-02-26 08:43:08.937+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=2 w=3, f=12 e=1 d=0
>2013-02-26 08:43:08.937+000015580: debug : virDomainDestroy:2172 : dom=0x7f7af42399e0, (VM: name=aaa, uuid=f33d9914-4add-c75f-3502-3cd73ea3b795)
>2013-02-26 08:43:08.937+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=3 w=4, f=13 e=1 d=0
>2013-02-26 08:43:08.937+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=4 w=5, f=6 e=1 d=0
>2013-02-26 08:43:08.937+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=5 w=6, f=16 e=1 d=0
>2013-02-26 08:43:08.937+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=6 w=7, f=17 e=1 d=0
>2013-02-26 08:43:08.937+000015580: debug : qemuProcessKill:4104 : vm=aaa pid=15676 flags=1
>2013-02-26 08:43:08.937+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=7 w=8, f=19 e=1 d=0
>2013-02-26 08:43:08.937+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=8 w=9, f=24 e=25 d=0
>2013-02-26 08:43:08.937+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=9 w=10, f=23 e=25 d=0
>2013-02-26 08:43:08.937+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=10 w=11, f=22 e=1 d=0
>2013-02-26 08:43:08.937+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=11 w=12, f=27 e=1 d=0
>2013-02-26 08:43:08.937+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=12 w=13, f=30 e=1 d=0
>2013-02-26 08:43:08.937+000015579: debug : virEventPollCalculateTimeout:320 : Calculate expiry of 9 timers
>2013-02-26 08:43:08.937+000015579: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361868189316
>2013-02-26 08:43:08.937+000015579: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361868191317
>2013-02-26 08:43:08.937+000015579: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361868191017
>2013-02-26 08:43:08.937+000015579: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361868191937
>2013-02-26 08:43:08.937+000015579: debug : virEventPollCalculateTimeout:346 : Timeout at 1361868189316 due in 379 ms
>2013-02-26 08:43:08.937+000015579: debug : virEventPollRunOnce:614 : EVENT_POLL_RUN: nhandles=13 timeout=379
>2013-02-26 08:43:08.937+000015579: debug : virEventPollRunOnce:625 : Poll got 1 event(s)
>2013-02-26 08:43:08.937+000015579: debug : virEventPollDispatchTimeouts:410 : Dispatch 9
>2013-02-26 08:43:08.937+000015579: debug : virEventPollDispatchHandles:455 : Dispatch 13
>2013-02-26 08:43:08.937+000015579: debug : virEventPollDispatchHandles:469 : i=0 w=1
>2013-02-26 08:43:08.937+000015579: debug : virEventPollDispatchHandles:469 : i=1 w=2
>2013-02-26 08:43:08.937+000015579: debug : virEventPollDispatchHandles:469 : i=2 w=3
>2013-02-26 08:43:08.937+000015579: debug : virEventPollDispatchHandles:469 : i=3 w=4
>2013-02-26 08:43:08.937+000015579: debug : virEventPollDispatchHandles:469 : i=4 w=5
>2013-02-26 08:43:08.937+000015579: debug : virEventPollDispatchHandles:469 : i=5 w=6
>2013-02-26 08:43:08.937+000015579: debug : virEventPollDispatchHandles:469 : i=6 w=7
>2013-02-26 08:43:08.937+000015579: debug : virEventPollDispatchHandles:469 : i=7 w=8
>2013-02-26 08:43:08.937+000015579: debug : virEventPollDispatchHandles:469 : i=8 w=9
>2013-02-26 08:43:08.937+000015579: debug : virEventPollDispatchHandles:483 : EVENT_POLL_DISPATCH_HANDLE: watch=9 events=1
>2013-02-26 08:43:08.937+000015579: debug : virObjectRef:168 : OBJECT_REF: obj=0x7f7aec003450
>2013-02-26 08:43:08.937+000015579: debug : qemuMonitorIOProcess:353 : QEMU_MONITOR_IO_PROCESS: mon=0x7f7aec003450 buf={"timestamp": {"seconds": 1361868188, "microseconds": 937650}, "event": "SHUTDOWN"}
> len=85
>2013-02-26 08:43:08.937+000015579: debug : qemuMonitorJSONIOProcessLine:152 : Line [{"timestamp": {"seconds": 1361868188, "microseconds": 937650}, "event": "SHUTDOWN"}]
>2013-02-26 08:43:08.937+000015579: debug : virJSONValueFromString:975 : string={"timestamp": {"seconds": 1361868188, "microseconds": 937650}, "event": "SHUTDOWN"}
>2013-02-26 08:43:08.937+000015579: debug : virJSONParserHandleStartMap:852 : parser=0x7fffeabb2e90
>2013-02-26 08:43:08.937+000015579: debug : virJSONParserHandleMapKey:833 : parser=0x7fffeabb2e90 key=0x1d83162
>2013-02-26 08:43:08.937+000015579: debug : virJSONParserHandleStartMap:852 : parser=0x7fffeabb2e90
>2013-02-26 08:43:08.937+000015579: debug : virJSONParserHandleMapKey:833 : parser=0x7fffeabb2e90 key=0x1d83170
>2013-02-26 08:43:08.937+000015579: debug : virJSONParserHandleNumber:792 : parser=0x7fffeabb2e90 str=(null)
>2013-02-26 08:43:08.937+000015579: debug : virJSONParserHandleMapKey:833 : parser=0x7fffeabb2e90 key=0x1d83187
>2013-02-26 08:43:08.937+000015579: debug : virJSONParserHandleNumber:792 : parser=0x7fffeabb2e90 str=(null)
>2013-02-26 08:43:08.937+000015579: debug : virJSONParserHandleEndMap:881 : parser=0x7fffeabb2e90
>2013-02-26 08:43:08.937+000015579: debug : virJSONParserHandleMapKey:833 : parser=0x7fffeabb2e90 key=0x1d831a0
>2013-02-26 08:43:08.937+000015579: debug : virJSONParserHandleString:813 : parser=0x7fffeabb2e90 str=0x1d831a9
>2013-02-26 08:43:08.937+000015579: debug : virJSONParserHandleEndMap:881 : parser=0x7fffeabb2e90
>2013-02-26 08:43:08.937+000015579: debug : virJSONValueFromString:1019 : result=0x1d5f600
>2013-02-26 08:43:08.937+000015579: debug : qemuMonitorJSONIOProcessLine:167 : QEMU_MONITOR_RECV_EVENT: mon=0x7f7aec003450 event={"timestamp": {"seconds": 1361868188, "microseconds": 937650}, "event": "SHUTDOWN"}
>2013-02-26 08:43:08.937+000015579: debug : qemuMonitorJSONIOProcessEvent:124 : mon=0x7f7aec003450 obj=0x1d5f600
>2013-02-26 08:43:08.937+000015579: debug : qemuMonitorJSONIOProcessEvent:138 : handle SHUTDOWN handler=0x4af1d0 data=(nil)
>2013-02-26 08:43:08.937+000015579: debug : qemuMonitorEmitShutdown:987 : mon=0x7f7aec003450
>2013-02-26 08:43:08.937+000015579: debug : virObjectRef:168 : OBJECT_REF: obj=0x7f7aec003450
>2013-02-26 08:43:08.937+000015579: debug : qemuProcessHandleShutdown:638 : vm=0x7f7af41839e0
>2013-02-26 08:43:09.137+000015580: debug : virObjectRef:168 : OBJECT_REF: obj=0x7f7af41839e0
>2013-02-26 08:43:09.137+000015580: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7f7af41839e0
>2013-02-26 08:43:09.137+000015580: debug : virObjectRef:168 : OBJECT_REF: obj=0x7f7af41839e0
>2013-02-26 08:43:09.137+000015579: debug : qemuProcessHandleShutdown:655 : Transitioned guest aaa to shutdown state
>2013-02-26 08:43:09.184+000015579: debug : virFileClose:72 : Closed fd 33
>2013-02-26 08:43:09.184+000015579: debug : qemuAgentNotifyEvent:1263 : mon=0x7f7aec00b160 event=1
>2013-02-26 08:43:09.184+000015579: warning : qemuAgentNotifyEvent:1274 : Received unexpected event 1
>2013-02-26 08:43:09.184+000015579: debug : qemuProcessKill:4104 : vm=aaa pid=15676 flags=2
>2013-02-26 08:43:09.184+000015579: debug : virEventPollUpdateTimeout:254 : EVENT_POLL_UPDATE_TIMEOUT: timer=5 frequency=0
>2013-02-26 08:43:09.184+000015579: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 106215520
>2013-02-26 08:43:09.184+000015579: debug : virObjectUnref:135 : OBJECT_UNREF2013-02-26 08:43:09.187+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=9 w=11, f=22 e=5 d=0
>2013-02-26 08:43:09.187+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=10 w=12, f=27 e=1 d=0
>2013-02-26 08:43:09.187+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=11 w=13, f=30 e=1 d=0
>2013-02-26 08:43:09.187+000015579: debug : virEventPollCalculateTimeout:320 : Calculate expiry of 9 timers
>2013-02-26 08:43:09.187+000015579: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361868189316
>2013-02-26 08:43:09.187+000015579: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361868191317
>2013-02-26 08:43:09.187+000015579: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361868191017
>2013-02-26 08:43:09.187+000015579: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361868191937
>2013-02-26 08:43:09.187+000015579: debug : virEventPollCalculateTimeout:346 : Timeout at 1361868189316 due in 129 ms
>2013-02-26 08:43:09.187+000015579: debug : virEventPollRunOnce:614 : EVENT_POLL_RUN: nhandles=12 timeout=129
>2013-02-26 08:43:09.187+000015579: debug : virEventPollRunOnce:625 : Poll got 5 event(s)
>2013-02-26 08:43:09.187+000015579: debug : virEventPollDispatchTimeouts:410 : Dispatch 9
>2013-02-26 08:43:09.187+000015579: debug : virEventPollDispatchHandles:455 : Dispatch 12
>2013-02-26 08:43:09.187+000015579: debug : virEventPollDispatchHandles:469 : i=0 w=1
>2013-02-26 08:43:09.187+000015579: debug : virEventPollDispatchHandles:483 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1
>0015579: debug : virEventPollMakePollFDs:378 : Prepare n=3 w=4, f=13 e=1 d=0
>2013-02-26 08:43:09.184+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=4 w=5, f=6 e=1 d=0
>2013-02-26 08:43:09.184+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=5 w=6, f=16 e=1 d=0
>2013-02-26 08:43:09.184+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=6 w=7, f=17 e=1 d=0
>2013-02-26 08:43:09.184+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=7 w=8, f=19 e=1 d=0
>2013-02-26 08:43:09.184+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=8 w=9, f=24 e=25 d=0
>2013-02-26 08:43:09.184+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=9 w=10, f=23 e=25 d=0
>2013-02-26 08:43:09.184+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=10 w=11, f=22 e=1 d=0
>2013-02-26 08:43:09.184+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=11 w=12, f=27 e=1 d=0
>2013-02-26 08:43:09.184+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=12 w=13, f=30 e=1 d=0
>2013-02-26 08:43:09.184+000015579: debug : virEventPollCalculateTimeout:320 : Calculate expiry of 9 timers
>2013-02-26 08:43:09.184+000015579: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361868189316
>2013-02-26 08:43:09.184+000015579: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361868191317
>2013-02-26 08:43:09.184+000015579: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361868189184
>2013-02-26 08:43:09.184+000015579: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361868191017
>2013-02-26 08:43:09.184+000015579: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361868191937
>2013-02-26 08:43:09.184+000015579: debug : virEventPollCalculateTimeout:346 : Timeout at 1361868189184 due in 0 ms
>2013-02-26 08:43:09.184+000015579: debug : virEventPollRunOnce:614 : EVENT_POLL_RUN: nhandles=13 timeout=0
>2013-02-26 08:43:09.184+000015579: debug : virEventPollRunOnce:625 : Poll got 4 event(s)
>2013-02-26 08:43:09.184+000015579: debug : virEventPollDispatchTimeouts:410 : Dispatch 9
>2013-02-26 08:43:09.184+000015579: debug : virEventPollDispatchTimeouts:433 : EVENT_POLL_DISPATCH_TIMEOUT: timer=5
>2013-02-26 08:43:09.184+000015579: debug : virEventPollUpdateTimeout:254 : EVENT_POLL_UPDATE_TIMEOUT: timer=5 frequency=-1
>2013-02-26 08:43:09.184+000015579: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 106215520
>2013-02-26 08:43:09.184+000015579: debug : virObjectNew:110 : OBJECT_NEW: obj=0x1d83840 classname=virDomain
>2013-02-26 08:43:09.184+000015579: debug : virObjectRef:168 : OBJECT_REF: obj=0x7f7af414b680
>2013-02-26 08:43:09.184+000015579: debug : remoteRelayDomainEventLifecycle:128 : Relaying domain lifecycle event 6 0
>2013-02-26 08:43:09.184+000015579: debug : virNetMessageNew:45 : msg=0x1d82030 tracked=0
>2013-02-26 08:43:09.184+000015579: debug : virNetMessageEncodePayload:358 : Encode length as 64
>2013-02-26 08:43:09.184+000015579: debug : remoteDispatchDomainEventSend:3237 : Queue event 107 64
>2013-02-26 08:43:09.184+000015579: debug : virNetServerClientSendMessageLocked:1119 : msg=0x1d82030 proc=107 len=64 offset=0
>2013-02-26 08:43:09.184+000015579: debug : virNetServerClientSendMessageLocked:1127 : RPC_SERVER_CLIENT_MSG_TX_QUEUE: client=0x1d81690 len=64 prog=536903814 vers=1 proc=107 type=2 status=0 serial=1
>2013-02-26 08:43:09.184+000015579: debug : virNetServerClientCalculateHandleMode:152 : tls=(nil) hs=-1, rx=0x1d81f50 tx=0x1d82030
>2013-02-26 08:43:09.184+000015579: debug : virNetServerClientCalculateHandleMode:183 : mode=3
>2013-02-26 08:43:09.184+000015579: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=11 events=3
>2013-02-26 08:43:09.184+000015579: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 106215520
>2013-02-26 08:43:09.184+000015579: debug : virDomainFree:2281 : dom=0x1d83840, (VM: name=aaa, uuid=f33d9914-4add-c75f-3502-3cd73ea3b795)
>2013-02-26 08:43:09.184+000015579: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x1d83840
>2013-02-26 08:43:09.184+000015579: debug : virObjectUnref:137 : OBJECT_DISPOSE: obj=0x1d83840
>2013-02-26 08:43:09.184+000015579: debug : virDomainDispose:225 : release domain 0x1d83840 aaa f33d9914-4add-c75f-3502-3cd73ea3b795
>2013-02-26 08:43:09.184+000015579: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7f7af414b680
>2013-02-26 08:43:09.184+000015579: debug : virEventPollDispatchHandles:455 : Dispatch 13
>2013-02-26 08:43:09.184+000015579: debug : virEventPollDispatchHandles:469 : i=0 w=1
>2013-02-26 08:43:09.184+000015579: debug : virEventPollDispatchHandles:469 : i=1 w=2
>2013-02-26 08:43:09.184+000015579: debug : virEventPollDispatchHandles:469 : i=2 w=3
>2013-02-26 08:43:09.184+000015579: debug : virEventPollDispatchHandles:469 : i=3 w=4
>2013-02-26 08:43:09.184+000015579: debug : virEventPollDispatchHandles:469 : i=4 w=5
>2013-02-26 08:43:09.184+000015579: debug : virEventPollDispatchHandles:469 : i=5 w=6
>2013-02-26 08:43:09.184+000015579: debug : virEventPollDispatchHandles:483 : EVENT_POLL_DISPATCH_HANDLE: watch=6 events=1
>2013-02-26 08:43:09.184+000015579: debug : virNetlinkEventCallback:346 : dispatching to max 0 clients, called from event watch 6
>2013-02-26 08:43:09.184+000015579: debug : virNetlinkEventCallback:359 : event not handled.
>2013-02-26 08:43:09.184+000015579: debug : virEventPollDispatchHandles:469 : i=6 w=7
>2013-02-26 08:43:09.184+000015579: debug : virEventPollDispatchHandles:483 : EVENT_POLL_DISPATCH_HANDLE: watch=7 events=1
>2013-02-26 08:43:09.184+000015579: debug : udevEventHandleCallback:1467 : udev action: 'remove'
>2013-02-26 08:43:09.184+000015579: debug : udevRemoveOneDevice:1218 : Failed to find device to remove that has udev name '/sys/devices/virtual/net/vnet0/queues/rx-0'
>2013-02-26 08:43:09.184+000015579: debug : virEventPollDispatchHandles:469 : i=7 w=8
>2013-02-26 08:43:09.184+000015579: debug : virEventPollDispatchHandles:469 : i=8 w=9
>2013-02-26 08:43:09.184+000015579: debug : virEventPollDispatchHandles:483 : EVENT_POLL_DISPATCH_HANDLE: watch=9 events=9
>2013-02-26 08:43:09.184+000015579: debug : virObjectRef:168 : OBJECT_REF: obj=0x7f7aec003450
>2013-02-26 08:43:09.184+000015579: error : qemuMonitorIO:613 : åé¨éè¯¯ End of file from monitor
>2013-02-26 08:43:09.184+000015579: debug : qemuMonitorIO:646 : Error on monitor åé¨éè¯¯ End of file from monitor
>2013-02-26 08:43:09.184+000015579: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=9 events=12
>2013-02-26 08:43:09.184+000015579: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 106215520
>2013-02-26 08:43:09.184+000015579: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7f7aec003450
>2013-02-26 08:43:09.184+000015579: debug : qemuMonitorIO:669 : Triggering EOF callback
>2013-02-26 08:43:09.184+000015579: debug : qemuProcessHandleMonitorEOF:283 : Received EOF on 0x7f7af41839e0 'aaa'
>2013-02-26 08:43:09.184+000015579: debug : qemuProcessHandleMonitorEOF:291 : Domain is being destroyed, EOF is expected
>2013-02-26 08:43:09.184+000015579: debug : virEventPollDispatchHandles:469 : i=9 w=10
>2013-02-26 08:43:09.184+000015579: debug : virEventPollDispatchHandles:483 : EVENT_POLL_DISPATCH_HANDLE: watch=10 events=9
>2013-02-26 08:43:09.184+000015579: debug : virObjectRef:168 : OBJECT_REF: obj=0x7f7aec00b160
>2013-02-26 08:43:09.184+000015579: error : qemuAgentIO:642 : åé¨éè¯¯ End of file from monitor
>2013-02-26 08:43:09.185+000015579: debug : qemuAgentIO:675 : Error on monitor åé¨éè¯¯ End of file from monitor
>2013-02-26 08:43:09.185+000015579: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=10 events=12
>2013-02-26 08:43:09.185+000015579: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 106215520
>2013-02-26 08:43:09.185+000015579: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7f7aec00b160
>2013-02-26 08:43:09.185+000015579: debug : qemuAgentIO:698 : Triggering EOF callback
>2013-02-26 08:43:09.185+000015579: debug : qemuProcessHandleAgentEOF:125 : Received EOF from agent on 0x7f7af41839e0 'aaa'
>2013-02-26 08:43:09.185+000015579: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7f7aec00b160
>2013-02-26 08:43:09.185+000015579: debug : qemuAgentClose:814 : mon=0x7f7aec00b160
>2013-02-26 08:43:09.185+000015579: debug : virEventPollRemoveHandle:175 : EVENT_POLL_REMOVE_HANDLE: watch=10
>2013-02-26 08:43:09.185+000015579: debug : virEventPollRemoveHandle:188 : mark delete 9 23
>2013-02-26 08:43:09.185+000015579: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 106215520
>2013-02-26 08:43:09.185+000015579: debug : virFileClose:72 : Closed fd 23
>2013-02-26 08:43:09.185+000015579: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7f7aec00b160
>2013-02-26 08:43:09.185+000015579: debug : virEventPollDispatchHandles:469 : i=10 w=11
>2013-02-26 08:43:09.185+000015579: debug : virEventPollDispatchHandles:469 : i=11 w=12
>2013-02-26 08:43:09.185+000015579: debug : virEventPollDispatchHandles:469 : i=12 w=13
>2013-02-26 08:43:09.185+000015579: debug : virEventPollCleanupTimeouts:501 : Cleanup 9
>2013-02-26 08:43:09.185+000015579: debug : virEventPollCleanupHandles:549 : Cleanup 13
>2013-02-26 08:43:09.185+000015579: debug : virEventPollCleanupHandles:562 : EVENT_POLL_PURGE_HANDLE: watch=10
>2013-02-26 08:43:09.185+000015579: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7f7aec00b160
>2013-02-26 08:43:09.185+000015584: debug : qemuAgentSend:900 : Send command resulted in error åé¨éè¯¯ End of file from monitor
>2013-02-26 08:43:09.185+000015579: debug : virObjectUnref:137 : OBJECT_DISPOSE: obj=0x7f7aec00b160
>2013-02-26 08:43:09.185+000015579: debug : qemuAgentDispose:169 : mon=0x7f7aec00b160
>2013-02-26 08:43:09.185+000015584: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=10 events=12
>2013-02-26 08:43:09.185+000015579: debug : qemuProcessHandleAgentDestroy:171 : Received destroy agent=0x7f7aec00b160 vm=0x7f7af41839e0
>2013-02-26 08:43:09.185+000015584: debug : virEventPollInterruptLocked:701 : Interrupting
>2013-02-26 08:43:09.185+000015579: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7f7af41839e0
>2013-02-26 08:43:09.187+000015584: debug : qemuAgentCommand:1023 : Receive command reply ret=-1 rxObject=(nil)
>2013-02-26 08:43:09.187+000015584: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7f7aec00b160
>2013-02-26 08:43:09.187+000015584: debug : qemuDomainObjEndJob:937 : Stopping job: modify (async=none)
>2013-02-26 08:43:09.187+000015584: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7f7af41839e0
>2013-02-26 08:43:09.187+000015584: debug : virDomainFree:2281 : dom=0x7f7ae80014c0, (VM: name=aaa, uuid=f33d9914-4add-c75f-3502-3cd73ea3b795)
>2013-02-26 08:43:09.187+000015584: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7f7ae80014c0
>2013-02-26 08:43:09.187+000015584: debug : virObjectUnref:137 : OBJECT_DISPOSE: obj=0x7f7ae80014c0
>2013-02-26 08:43:09.187+000015579: debug : virEventRunDefaultImpl:244 : running default event implementation
>2013-02-26 08:43:09.187+000015584: debug : virDomainDispose:225 : release domain 0x7f7ae80014c0 aaa f33d9914-4add-c75f-3502-3cd73ea3b795
>2013-02-26 08:43:09.187+000015579: debug : virEventPollCleanupTimeouts:501 : Cleanup 9
>2013-02-26 08:43:09.187+000015584: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7f7af0000bd0
>2013-02-26 08:43:09.187+000015579: debug : virEventPollCleanupHandles:549 : Cleanup 12
>2013-02-26 08:43:09.187+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=0 w=1, f=7 e=1 d=0
>2013-02-26 08:43:09.187+000015584: debug : virNetServerProgramSendError:150 : prog=536903814 ver=1 proc=261 type=1 serial=11 msg=0x1d82d20 rerr=0x7f7afdeb4b80
>2013-02-26 08:43:09.187+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=1 w=2, f=9 e=1 d=0
>2013-02-26 08:43:09.187+000015581: debug : qemuDomainObjBeginJobInternal:808 : Starting job: modify (async=none)
>2013-02-26 08:43:09.187+000015581: debug : virObjectRef:168 : OBJECT_REF: obj=0x7f7aec00b160
>2013-02-26 08:43:09.187+000015584: debug : virNetMessageEncodePayload:358 : Encode length as 164
>2013-02-26 08:43:09.187+000015584: debug : virNetServerClientSendMessageLocked:1119 : msg=0x1d82d20 proc=261 len=164 offset=0
>2013-02-26 08:43:09.187+000015581: debug : qemuAgentGuestSync:948 : Sending guest-sync command with ID: 1361868189187
>2013-02-26 08:43:09.187+000015581: debug : qemuAgentSend:866 : Attempt to send command while error is set oc=60
>2013-02-26 08:43:09.187+000015584: debug : virNetServerClientSendMessageLocked:1127 : RPC_SERVER_CLIENT_MSG_TX_QUEUE: client=0x1d825e0 len=164 prog=536903814 vers=1 proc=261 type=1 status=1 serial=11
>2013-02-26 08:43:09.187+000015584: debug : virNetServerClientCalculateHandleMode:152 : tls=(nil) hs=-1, rx=0x1d817e0 tx=0x1d82d20
>2013-02-26 08:43:09.187+000015584: debug : virNetServerClientCalculateHandleMode:183 : mode=3
>2013-02-26 08:43:09.187+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=2 w=3, f=12 e=1 d=0
>2013-02-26 08:43:09.187+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=3 w=4, f=13 e=1 d=0
>2013-02-26 08:43:09.187+000015584: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=8 events=3
>2013-02-26 08:43:09.187+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=4 w=5, f=6 e=1 d=0
>2013-02-26 08:43:09.187+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=5 w=6, f=16 e=1 d=0
>2013-02-26 08:43:09.187+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=6 w=7, f=17 e=1 d=0
>2013-02-26 08:43:09.187+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=7 w=8, f=19 e=1 d=0
>2013-02-26 08:43:09.187+000015579: debug : virEventPollMakePollFDs:378 : Prepare n=8 w=9, f=24 e=24 d=0
>
>
>     ====== end of log =====
>
>2013-02-26 08:48:46.229+0000: 16522: info : libvirt version: 0.10.2, package: 18.el6 (Red Hat, Inc. <http://bugzilla.redhat.com/bugzilla>, 2013-01-28-15:42:10, x86-003.build.bos.redhat.com)
>2013-02-26 08:48:46.229+0000: 16522: error : qemuMonitorOpenUnix:292 : failed to connect to monitor socket: æ²¡æé£ä¸ªè¿ç¨
>2013-02-26 08:48:51.399+0000: 16546: info : libvirt version: 0.10.2, package: 18.el6 (Red Hat, Inc. <http://bugzilla.redhat.com/bugzilla>, 2013-01-28-15:42:10, x86-003.build.bos.redhat.com)
>2013-02-26 08:48:51.399+0000: 16546: warning : virCgroupMoveTask:885 : no vm cgroup in controller 3
>2013-02-26 08:48:51.399+0000: 16546: warning : virCgroupMoveTask:885 : no vm cgroup in controller 4
>2013-02-26 08:48:51.399+0000: 16546: warning : virCgroupMoveTask:885 : no vm cgroup in controller 6
>2013-02-26 08:49:48.701+0000: 16545: warning : qemuAgentNotifyEvent:1274 : Received unexpected event 3
>2013-02-26 08:50:45.272+0000: 16545: warning : qemuAgentNotifyEvent:1274 : Received unexpected event 3
>2013-02-26 08:56:08.146+0000: 16546: warning : virCgroupMoveTask:885 : no vm cgroup in controller 3
>2013-02-26 08:56:08.146+0000: 16546: warning : virCgroupMoveTask:885 : no vm cgroup in controller 4
>2013-02-26 08:56:08.146+0000: 16546: warning : virCgroupMoveTask:885 : no vm cgroup in controller 6
>2013-02-26 08:58:22.247+0000: 16545: warning : qemuAgentNotifyEvent:1274 : Received unexpected event 1
>2013-02-26 08:58:22.247+0000: 16545: error : qemuMonitorIO:613 : åé¨éè¯¯ End of file from monitor
>2013-02-26 08:58:22.247+0000: 16545: error : qemuAgentIO:642 : åé¨éè¯¯ End of file from monitor
>Caught Segmentation violation dumping internal log buffer:
>
>
>    ====== start of log =====
>
> n=10 w=13, f=30 e=25 d=0
>2013-02-26 08:58:21.974+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=11 w=14, f=27 e=25 d=0
>2013-02-26 08:58:21.974+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=12 w=15, f=26 e=1 d=0
>2013-02-26 08:58:21.974+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=13 w=16, f=33 e=1 d=0
>2013-02-26 08:58:21.974+000016545: debug : virEventPollCalculateTimeout:320 : Calculate expiry of 11 timers
>2013-02-26 08:58:21.974+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869104826
>2013-02-26 08:58:21.974+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869104323
>2013-02-26 08:58:21.974+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869102621
>2013-02-26 08:58:21.974+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869103634
>2013-02-26 08:58:21.974+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869104970
>2013-02-26 08:58:21.974+000016545: debug : virEventPollCalculateTimeout:346 : Timeout at 1361869102621 due in 647 ms
>2013-02-26 08:58:21.974+000016545: debug : virEventPollRunOnce:614 : EVENT_POLL_RUN: nhandles=14 timeout=647
>2013-02-26 08:58:21.974+000016545: debug : virEventPollRunOnce:625 : Poll got 1 event(s)
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchTimeouts:410 : Dispatch 11
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:455 : Dispatch 14
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:469 : i=0 w=1
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:469 : i=1 w=2
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:469 : i=2 w=3
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:469 : i=3 w=4
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:469 : i=4 w=5
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:469 : i=5 w=6
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:469 : i=6 w=7
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:469 : i=7 w=8
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:469 : i=8 w=9
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:469 : i=9 w=12
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:469 : i=10 w=13
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:469 : i=11 w=14
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:469 : i=12 w=15
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:469 : i=13 w=16
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:483 : EVENT_POLL_DISPATCH_HANDLE: watch=16 events=1
>2013-02-26 08:58:21.974+000016545: debug : virNetMessageDecodeLength:152 : Got length, now need 28 total (24 more)
>2013-02-26 08:58:21.974+000016545: debug : virNetServerClientCalculateHandleMode:152 : tls=(nil) hs=-1, rx=0x1f68d20 tx=(nil)
>2013-02-26 08:58:21.974+000016545: debug : virNetServerClientCalculateHandleMode:183 : mode=1
>2013-02-26 08:58:21.974+000016545: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=16 events=1
>2013-02-26 08:58:21.974+000016545: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 1267492960
>2013-02-26 08:58:21.974+000016545: debug : virNetServerClientDispatchRead:875 : RPC_SERVER_CLIENT_MSG_RX: client=0x1f67700 len=28 prog=536903814 vers=1 proc=110 type=0 status=0 serial=3
>2013-02-26 08:58:21.974+000016545: debug : virKeepAliveCheckMessage:384 : ka=0x1f69060, client=0x1f67700, msg=0x1f68d20
>2013-02-26 08:58:21.974+000016545: debug : virEventPollUpdateTimeout:254 : EVENT_POLL_UPDATE_TIMEOUT: timer=11 frequency=3000
>2013-02-26 08:58:21.974+000016545: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 1267492960
>2013-02-26 08:58:21.974+000016545: debug : virObjectRef:168 : OBJECT_REF: obj=0x1f67700
>2013-02-26 08:58:21.974+000016545: debug : virNetServerDispatchNewMessage:218 : server=0x1f5ed50 client=0x1f67700 message=0x1f68d20
>2013-02-26 08:58:21.974+000016545: debug : virObjectRef:168 : OBJECT_REF: obj=0x1f69f70
>2013-02-26 08:58:21.974+000016545: debug : virNetMessageNew:45 : msg=0x1f660f0 tracked=1
>2013-02-26 08:58:21.974+000016545: debug : virNetServerClientCalculateHandleMode:152 : tls=(nil) hs=-1, rx=0x1f660f0 tx=(nil)
>2013-02-26 08:58:21.974+000016547: debug : virNetServerHandleJob:189 : server=0x1f5ed50 client=0x1f67700 message=0x1f68d20 prog=0x1f69f70
>2013-02-26 08:58:21.974+000016545: debug : virNetServerClientCalculateHandleMode:183 : mode=1
>2013-02-26 08:58:21.974+000016545: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=16 events=1
>2013-02-26 08:58:21.974+000016547: debug : virNetServerProgramDispatch:284 : prog=536903814 ver=1 type=0 status=0 serial=3 proc=110
>2013-02-26 08:58:21.974+000016545: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 1267492960
>2013-02-26 08:58:21.974+000016545: debug : virEventPollCleanupTimeouts:501 : Cleanup 11
>2013-02-26 08:58:21.974+000016545: debug : virEventPollCleanupHandles:549 : Cleanup 14
>2013-02-26 08:58:21.974+000016545: debug : virEventRunDefaultImpl:244 : running default event implementation
>2013-02-26 08:58:21.974+000016547: debug : remoteDispatchGetURIHelper:7297 : server=0x1f5ed50 client=0x1f67700 msg=0x1f68d20 rerr=0x7fb445032b80 args=0x7fb4300008c0 ret=0x7fb430000c40
>2013-02-26 08:58:21.974+000016545: debug : virEventPollCleanupTimeouts:501 : Cleanup 11
>2013-02-26 08:58:21.974+000016547: debug : virConnectGetURI:1700 : conn=0x7fb410074e50
>2013-02-26 08:58:21.974+000016545: debug : virEventPollCleanupHandles:549 : Cleanup 14
>2013-02-26 08:58:21.974+000016547: debug : virNetMessageEncodePayload:358 : Encode length as 48
>2013-02-26 08:58:21.974+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=0 w=1, f=7 e=1 d=0
>2013-02-26 08:58:21.974+000016547: debug : virNetServerClientSendMessageLocked:1119 : msg=0x1f68d20 proc=110 len=48 offset=0
>2013-02-26 08:58:21.974+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=1 w=2, f=9 e=1 d=0
>2013-02-26 08:58:21.974+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=2 w=3, f=12 e=1 d=0
>2013-02-26 08:58:21.974+000016547: debug : virNetServerClientSendMessageLocked:1127 : RPC_SERVER_CLIENT_MSG_TX_QUEUE: client=0x1f67700 len=48 prog=536903814 vers=1 proc=110 type=1 status=0 serial=3
>2013-02-26 08:58:21.974+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=3 w=4, f=13 e=1 d=0
>2013-02-26 08:58:21.974+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=4 w=5, f=6 e=1 d=0
>2013-02-26 08:58:21.974+000016547: debug : virNetServerClientCalculateHandleMode:152 : tls=(nil) hs=-1, rx=0x1f660f0 tx=0x1f68d20
>2013-02-26 08:58:21.974+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=5 w=6, f=14 e=1 d=0
>2013-02-26 08:58:21.974+000016547: debug : virNetServerClientCalculateHandleMode:183 : mode=3
>2013-02-26 08:58:21.974+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=6 w=7, f=17 e=1 d=0
>2013-02-26 08:58:21.974+000016547: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=16 events=3
>2013-02-26 08:58:21.974+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=7 w=8, f=19 e=1 d=0
>2013-02-26 08:58:21.974+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=8 w=9, f=22 e=1 d=0
>2013-02-26 08:58:21.974+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=9 w=12, f=25 e=1 d=0
>2013-02-26 08:58:21.974+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=10 w=13, f=30 e=25 d=0
>2013-02-26 08:58:21.974+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=11 w=14, f=27 e=25 d=0
>2013-02-26 08:58:21.974+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=12 w=15, f=26 e=1 d=0
>2013-02-26 08:58:21.974+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=13 w=16, f=33 e=1 d=0
>2013-02-26 08:58:21.974+000016545: debug : virEventPollCalculateTimeout:320 : Calculate expiry of 11 timers
>2013-02-26 08:58:21.974+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869104826
>2013-02-26 08:58:21.974+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869104323
>2013-02-26 08:58:21.974+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869102621
>2013-02-26 08:58:21.974+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869103634
>2013-02-26 08:58:21.974+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869104974
>2013-02-26 08:58:21.974+000016545: debug : virEventPollCalculateTimeout:346 : Timeout at 1361869102621 due in 647 ms
>2013-02-26 08:58:21.974+000016545: debug : virEventPollRunOnce:614 : EVENT_POLL_RUN: nhandles=14 timeout=647
>2013-02-26 08:58:21.974+000016547: debug : virEventPollInterruptLocked:701 : Interrupting
>2013-02-26 08:58:21.974+000016547: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x1f69f70
>2013-02-26 08:58:21.974+000016545: debug : virEventPollRunOnce:625 : Poll got 1 event(s)
>2013-02-26 08:58:21.974+000016547: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x1f67700
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchTimeouts:410 : Dispatch 11
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:455 : Dispatch 14
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:469 : i=0 w=1
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:483 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:469 : i=1 w=2
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:469 : i=2 w=3
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:469 : i=3 w=4
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:469 : i=4 w=5
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:469 : i=5 w=6
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:469 : i=6 w=7
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:469 : i=7 w=8
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:469 : i=8 w=9
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:469 : i=9 w=12
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:469 : i=10 w=13
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:469 : i=11 w=14
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:469 : i=12 w=15
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:469 : i=13 w=16
>2013-02-26 08:58:21.974+000016545: debug : virEventPollCleanupTimeouts:501 : Cleanup 11
>2013-02-26 08:58:21.974+000016545: debug : virEventPollCleanupHandles:549 : Cleanup 14
>2013-02-26 08:58:21.974+000016545: debug : virEventRunDefaultImpl:244 : running default event implementation
>2013-02-26 08:58:21.974+000016545: debug : virEventPollCleanupTimeouts:501 : Cleanup 11
>2013-02-26 08:58:21.974+000016545: debug : virEventPollCleanupHandles:549 : Cleanup 14
>2013-02-26 08:58:21.974+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=0 w=1, f=7 e=1 d=0
>2013-02-26 08:58:21.974+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=1 w=2, f=9 e=1 d=0
>2013-02-26 08:58:21.974+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=2 w=3, f=12 e=1 d=0
>2013-02-26 08:58:21.974+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=3 w=4, f=13 e=1 d=0
>2013-02-26 08:58:21.974+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=4 w=5, f=6 e=1 d=0
>2013-02-26 08:58:21.974+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=5 w=6, f=14 e=1 d=0
>2013-02-26 08:58:21.974+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=6 w=7, f=17 e=1 d=0
>2013-02-26 08:58:21.974+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=7 w=8, f=19 e=1 d=0
>2013-02-26 08:58:21.974+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=8 w=9, f=22 e=1 d=0
>2013-02-26 08:58:21.974+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=9 w=12, f=25 e=1 d=0
>2013-02-26 08:58:21.974+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=10 w=13, f=30 e=25 d=0
>2013-02-26 08:58:21.974+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=11 w=14, f=27 e=25 d=0
>2013-02-26 08:58:21.974+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=12 w=15, f=26 e=1 d=0
>2013-02-26 08:58:21.974+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=13 w=16, f=33 e=5 d=0
>2013-02-26 08:58:21.974+000016545: debug : virEventPollCalculateTimeout:320 : Calculate expiry of 11 timers
>2013-02-26 08:58:21.974+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869104826
>2013-02-26 08:58:21.974+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869104323
>2013-02-26 08:58:21.974+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869102621
>2013-02-26 08:58:21.974+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869103634
>2013-02-26 08:58:21.974+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869104974
>2013-02-26 08:58:21.974+000016545: debug : virEventPollCalculateTimeout:346 : Timeout at 1361869102621 due in 647 ms
>2013-02-26 08:58:21.974+000016545: debug : virEventPollRunOnce:614 : EVENT_POLL_RUN: nhandles=14 timeout=647
>2013-02-26 08:58:21.974+000016545: debug : virEventPollRunOnce:625 : Poll got 1 event(s)
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchTimeouts:410 : Dispatch 11
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:455 : Dispatch 14
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:469 : i=0 w=1
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:469 : i=1 w=2
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:469 : i=2 w=3
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:469 : i=3 w=4
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:469 : i=4 w=5
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:469 : i=5 w=6
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:469 : i=6 w=7
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:469 : i=7 w=8
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:469 : i=8 w=9
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:469 : i=9 w=12
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:469 : i=10 w=13
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:469 : i=11 w=14
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:469 : i=12 w=15
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:469 : i=13 w=16
>2013-02-26 08:58:21.974+000016545: debug : virEventPollDispatchHandles:483 : EVENT_POLL_DISPATCH_HANDLE: watch=16 events=2
>2013-02-26 08:58:21.974+000016545: debug : virNetMessageFree:73 : msg=0x1f68d20 nfds=0 cb=(nil)
>2013-02-26 08:58:21.974+000016545: debug : virNetServerClientCalculateHandleMode:152 : tls=(nil) hs=-1, rx=0x1f660f0 tx=(nil)
>2013-02-26 08:58:21.974+000016545: debug : virNetServerClientCalculateHandleMode:183 : mode=1
>2013-02-26 08:58:21.974+000016545: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=16 events=1
>2013-02-26 08:58:21.974+000016545: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 1267492960
>2013-02-26 08:58:21.974+000016545: debug : virEventPollCleanupTimeouts:501 : Cleanup 11
>2013-02-26 08:58:21.974+000016545: debug : virEventPollCleanupHandles:549 : Cleanup 14
>2013-02-26 08:58:21.974+000016545: debug : virEventRunDefaultImpl:244 : running default event implementation
>2013-02-26 08:58:21.974+000016545: debug : virEventPollCleanupTimeouts:501 : Cleanup 11
>2013-02-26 08:58:21.974+000016545: debug : virEventPollCleanupHandles:549 : Cleanup 14
>2013-02-26 08:58:21.974+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=0 w=1, f=7 e=1 d=0
>2013-02-26 08:58:21.974+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=1 w=2, f=9 e=1 d=0
>2013-02-26 08:58:21.974+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=2 w=3, f=12 e=1 d=0
>2013-02-26 08:58:21.974+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=3 w=4, f=13 e=1 d=0
>2013-02-26 08:58:21.974+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=4 w=5, f=6 e=1 d=0
>2013-02-26 08:58:21.974+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=5 w=6, f=14 e=1 d=0
>2013-02-26 08:58:21.974+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=6 w=7, f=17 e=1 d=0
>2013-02-26 08:58:21.974+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=7 w=8, f=19 e=1 d=0
>2013-02-26 08:58:21.974+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=8 w=9, f=22 e=1 d=0
>2013-02-26 08:58:21.974+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=9 w=12, f=25 e=1 d=0
>2013-02-26 08:58:21.974+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=10 w=13, f=30 e=25 d=0
>2013-02-26 08:58:21.974+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=11 w=14, f=27 e=25 d=0
>2013-02-26 08:58:21.974+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=12 w=15, f=26 e=1 d=0
>2013-02-26 08:58:21.974+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=13 w=16, f=33 e=1 d=0
>2013-02-26 08:58:21.974+000016545: debug : virEventPollCalculateTimeout:320 : Calculate expiry of 11 timers
>2013-02-26 08:58:21.974+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869104826
>2013-02-26 08:58:21.974+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869104323
>2013-02-26 08:58:21.974+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869102621
>2013-02-26 08:58:21.974+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869103634
>2013-02-26 08:58:21.974+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869104974
>2013-02-26 08:58:21.974+000016545: debug : virEventPollCalculateTimeout:346 : Timeout at 1361869102621 due in 647 ms
>2013-02-26 08:58:21.974+000016545: debug : virEventPollRunOnce:614 : EVENT_POLL_RUN: nhandles=14 timeout=647
>2013-02-26 08:58:21.974+000016545: debug : virEventPollRunOnce:625 : Poll got 1 event(s)
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchTimeouts:410 : Dispatch 11
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:455 : Dispatch 14
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=0 w=1
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=1 w=2
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=2 w=3
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=3 w=4
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=4 w=5
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=5 w=6
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=6 w=7
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=7 w=8
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=8 w=9
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=9 w=12
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=10 w=13
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=11 w=14
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=12 w=15
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=13 w=16
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:483 : EVENT_POLL_DISPATCH_HANDLE: watch=16 events=1
>2013-02-26 08:58:21.975+000016545: debug : virNetMessageDecodeLength:152 : Got length, now need 36 total (32 more)
>2013-02-26 08:58:21.975+000016545: debug : virNetServerClientCalculateHandleMode:152 : tls=(nil) hs=-1, rx=0x1f660f0 tx=(nil)
>2013-02-26 08:58:21.975+000016545: debug : virNetServerClientCalculateHandleMode:183 : mode=1
>2013-02-26 08:58:21.975+000016545: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=16 events=1
>2013-02-26 08:58:21.975+000016545: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 1267492960
>2013-02-26 08:58:21.975+000016545: debug : virNetServerClientDispatchRead:875 : RPC_SERVER_CLIENT_MSG_RX: client=0x1f67700 len=36 prog=536903814 vers=1 proc=23 type=0 status=0 serial=4
>2013-02-26 08:58:21.975+000016545: debug : virKeepAliveCheckMessage:384 : ka=0x1f69060, client=0x1f67700, msg=0x1f660f0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollUpdateTimeout:254 : EVENT_POLL_UPDATE_TIMEOUT: timer=11 frequency=3000
>2013-02-26 08:58:21.975+000016545: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 1267492960
>2013-02-26 08:58:21.975+000016545: debug : virObjectRef:168 : OBJECT_REF: obj=0x1f67700
>2013-02-26 08:58:21.975+000016545: debug : virNetServerDispatchNewMessage:218 : server=0x1f5ed50 client=0x1f67700 message=0x1f660f0
>2013-02-26 08:58:21.975+000016545: debug : virObjectRef:168 : OBJECT_REF: obj=0x1f69f70
>2013-02-26 08:58:21.975+000016545: debug : virNetMessageNew:45 : msg=0x1f6ab90 tracked=1
>2013-02-26 08:58:21.975+000016545: debug : virNetServerClientCalculateHandleMode:152 : tls=(nil) hs=-1, rx=0x1f6ab90 tx=(nil)
>2013-02-26 08:58:21.975+000016548: debug : virNetServerHandleJob:189 : server=0x1f5ed50 client=0x1f67700 message=0x1f660f0 prog=0x1f69f70
>2013-02-26 08:58:21.975+000016545: debug : virNetServerClientCalculateHandleMode:183 : mode=1
>2013-02-26 08:58:21.975+000016545: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=16 events=1
>2013-02-26 08:58:21.975+000016548: debug : virNetServerProgramDispatch:284 : prog=536903814 ver=1 type=0 status=0 serial=4 proc=23
>2013-02-26 08:58:21.975+000016545: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 1267492960
>2013-02-26 08:58:21.975+000016545: debug : virEventPollCleanupTimeouts:501 : Cleanup 11
>2013-02-26 08:58:21.975+000016545: debug : virEventPollCleanupHandles:549 : Cleanup 14
>2013-02-26 08:58:21.975+000016548: debug : remoteDispatchDomainLookupByNameHelper:3084 : server=0x1f5ed50 client=0x1f67700 msg=0x1f660f0 rerr=0x7fb444631b80 args=0x7fb4340c1cd0 ret=0x7fb4340c1d30
>2013-02-26 08:58:21.975+000016545: debug : virEventRunDefaultImpl:244 : running default event implementation
>2013-02-26 08:58:21.975+000016545: debug : virEventPollCleanupTimeouts:501 : Cleanup 11
>2013-02-26 08:58:21.975+000016548: debug : virDomainLookupByName:2117 : conn=0x7fb410074e50, name=aaa
>2013-02-26 08:58:21.975+000016545: debug : virEventPollCleanupHandles:549 : Cleanup 14
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=0 w=1, f=7 e=1 d=0
>2013-02-26 08:58:21.975+000016548: debug : virObjectNew:110 : OBJECT_NEW: obj=0x7fb4340c1cf0 classname=virDomain
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=1 w=2, f=9 e=1 d=0
>2013-02-26 08:58:21.975+000016548: debug : virObjectRef:168 : OBJECT_REF: obj=0x7fb410074e50
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=2 w=3, f=12 e=1 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=3 w=4, f=13 e=1 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=4 w=5, f=6 e=1 d=0
>2013-02-26 08:58:21.975+000016548: debug : virDomainFree:2281 : dom=0x7fb4340c1cf0, (VM: name=aaa, uuid=f33d9914-4add-c75f-3502-3cd73ea3b795)
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=5 w=6, f=14 e=1 d=0
>2013-02-26 08:58:21.975+000016548: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7fb4340c1cf0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=6 w=7, f=17 e=1 d=0
>2013-02-26 08:58:21.975+000016548: debug : virObjectUnref:137 : OBJECT_DISPOSE: obj=0x7fb4340c1cf0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=7 w=8, f=19 e=1 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=8 w=9, f=22 e=1 d=0
>2013-02-26 08:58:21.975+000016548: debug : virDomainDispose:225 : release domain 0x7fb4340c1cf0 aaa f33d9914-4add-c75f-3502-3cd73ea3b795
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=9 w=12, f=25 e=1 d=0
>2013-02-26 08:58:21.975+000016548: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7fb410074e50
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=10 w=13, f=30 e=25 d=0
>2013-02-26 08:58:21.975+000016548: debug : virNetMessageEncodePayload:358 : Encode length as 56
>2013-02-26 08:58:21.975+000016548: debug : virNetServerClientSendMessageLocked:1119 : msg=0x1f660f0 proc=23 len=56 offset=0
>2013-02-26 08:58:21.975+000016548: debug : virNetServerClientSendMessageLocked:1127 : RPC_SERVER_CLIENT_MSG_TX_QUEUE: client=0x1f67700 len=56 prog=536903814 vers=1 proc=23 type=1 status=0 serial=4
>2013-02-26 08:58:21.975+000016548: debug : virNetServerClientCalculateHandleMode:152 : tls=(nil) hs=-1, rx=0x1f6ab90 tx=0x1f660f0
>2013-02-26 08:58:21.975+000016548: debug : virNetServerClientCalculateHandleMode:183 : mode=3
>2013-02-26 08:58:21.975+000016548: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=16 events=3
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=11 w=14, f=27 e=25 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=12 w=15, f=26 e=1 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=13 w=16, f=33 e=1 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollCalculateTimeout:320 : Calculate expiry of 11 timers
>2013-02-26 08:58:21.975+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869104826
>2013-02-26 08:58:21.975+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869104323
>2013-02-26 08:58:21.975+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869102621
>2013-02-26 08:58:21.975+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869103634
>2013-02-26 08:58:21.975+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869104975
>2013-02-26 08:58:21.975+000016545: debug : virEventPollCalculateTimeout:346 : Timeout at 1361869102621 due in 646 ms
>2013-02-26 08:58:21.975+000016545: debug : virEventPollRunOnce:614 : EVENT_POLL_RUN: nhandles=14 timeout=646
>2013-02-26 08:58:21.975+000016548: debug : virEventPollInterruptLocked:701 : Interrupting
>2013-02-26 08:58:21.975+000016548: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x1f69f70
>2013-02-26 08:58:21.975+000016548: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x1f67700
>2013-02-26 08:58:21.975+000016545: debug : virEventPollRunOnce:625 : Poll got 1 event(s)
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchTimeouts:410 : Dispatch 11
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:455 : Dispatch 14
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=0 w=1
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:483 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=1 w=2
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=2 w=3
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=3 w=4
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=4 w=5
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=5 w=6
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=6 w=7
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=7 w=8
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=8 w=9
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=9 w=12
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=10 w=13
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=11 w=14
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=12 w=15
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=13 w=16
>2013-02-26 08:58:21.975+000016545: debug : virEventPollCleanupTimeouts:501 : Cleanup 11
>2013-02-26 08:58:21.975+000016545: debug : virEventPollCleanupHandles:549 : Cleanup 14
>2013-02-26 08:58:21.975+000016545: debug : virEventRunDefaultImpl:244 : running default event implementation
>2013-02-26 08:58:21.975+000016545: debug : virEventPollCleanupTimeouts:501 : Cleanup 11
>2013-02-26 08:58:21.975+000016545: debug : virEventPollCleanupHandles:549 : Cleanup 14
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=0 w=1, f=7 e=1 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=1 w=2, f=9 e=1 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=2 w=3, f=12 e=1 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=3 w=4, f=13 e=1 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=4 w=5, f=6 e=1 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=5 w=6, f=14 e=1 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=6 w=7, f=17 e=1 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=7 w=8, f=19 e=1 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=8 w=9, f=22 e=1 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=9 w=12, f=25 e=1 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=10 w=13, f=30 e=25 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=11 w=14, f=27 e=25 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=12 w=15, f=26 e=1 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=13 w=16, f=33 e=5 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollCalculateTimeout:320 : Calculate expiry of 11 timers
>2013-02-26 08:58:21.975+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869104826
>2013-02-26 08:58:21.975+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869104323
>2013-02-26 08:58:21.975+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869102621
>2013-02-26 08:58:21.975+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869103634
>2013-02-26 08:58:21.975+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869104975
>2013-02-26 08:58:21.975+000016545: debug : virEventPollCalculateTimeout:346 : Timeout at 1361869102621 due in 646 ms
>2013-02-26 08:58:21.975+000016545: debug : virEventPollRunOnce:614 : EVENT_POLL_RUN: nhandles=14 timeout=646
>2013-02-26 08:58:21.975+000016545: debug : virEventPollRunOnce:625 : Poll got 1 event(s)
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchTimeouts:410 : Dispatch 11
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:455 : Dispatch 14
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=0 w=1
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=1 w=2
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=2 w=3
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=3 w=4
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=4 w=5
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=5 w=6
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=6 w=7
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=7 w=8
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=8 w=9
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=9 w=12
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=10 w=13
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=11 w=14
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=12 w=15
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=13 w=16
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:483 : EVENT_POLL_DISPATCH_HANDLE: watch=16 events=2
>2013-02-26 08:58:21.975+000016545: debug : virNetMessageFree:73 : msg=0x1f660f0 nfds=0 cb=(nil)
>2013-02-26 08:58:21.975+000016545: debug : virNetServerClientCalculateHandleMode:152 : tls=(nil) hs=-1, rx=0x1f6ab90 tx=(nil)
>2013-02-26 08:58:21.975+000016545: debug : virNetServerClientCalculateHandleMode:183 : mode=1
>2013-02-26 08:58:21.975+000016545: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=16 events=1
>2013-02-26 08:58:21.975+000016545: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 1267492960
>2013-02-26 08:58:21.975+000016545: debug : virEventPollCleanupTimeouts:501 : Cleanup 11
>2013-02-26 08:58:21.975+000016545: debug : virEventPollCleanupHandles:549 : Cleanup 14
>2013-02-26 08:58:21.975+000016545: debug : virEventRunDefaultImpl:244 : running default event implementation
>2013-02-26 08:58:21.975+000016545: debug : virEventPollCleanupTimeouts:501 : Cleanup 11
>2013-02-26 08:58:21.975+000016545: debug : virEventPollCleanupHandles:549 : Cleanup 14
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=0 w=1, f=7 e=1 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=1 w=2, f=9 e=1 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=2 w=3, f=12 e=1 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=3 w=4, f=13 e=1 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=4 w=5, f=6 e=1 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=5 w=6, f=14 e=1 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=6 w=7, f=17 e=1 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=7 w=8, f=19 e=1 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=8 w=9, f=22 e=1 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=9 w=12, f=25 e=1 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=10 w=13, f=30 e=25 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=11 w=14, f=27 e=25 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=12 w=15, f=26 e=1 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=13 w=16, f=33 e=1 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollCalculateTimeout:320 : Calculate expiry of 11 timers
>2013-02-26 08:58:21.975+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869104826
>2013-02-26 08:58:21.975+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869104323
>2013-02-26 08:58:21.975+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869102621
>2013-02-26 08:58:21.975+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869103634
>2013-02-26 08:58:21.975+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869104975
>2013-02-26 08:58:21.975+000016545: debug : virEventPollCalculateTimeout:346 : Timeout at 1361869102621 due in 646 ms
>2013-02-26 08:58:21.975+000016545: debug : virEventPollRunOnce:614 : EVENT_POLL_RUN: nhandles=14 timeout=646
>2013-02-26 08:58:21.975+000016545: debug : virEventPollRunOnce:625 : Poll got 1 event(s)
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchTimeouts:410 : Dispatch 11
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:455 : Dispatch 14
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=0 w=1
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=1 w=2
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=2 w=3
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=3 w=4
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=4 w=5
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=5 w=6
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=6 w=7
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=7 w=8
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=8 w=9
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=9 w=12
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=10 w=13
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=11 w=14
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=12 w=15
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:469 : i=13 w=16
>2013-02-26 08:58:21.975+000016545: debug : virEventPollDispatchHandles:483 : EVENT_POLL_DISPATCH_HANDLE: watch=16 events=1
>2013-02-26 08:58:21.975+000016545: debug : virNetMessageDecodeLength:152 : Got length, now need 56 total (52 more)
>2013-02-26 08:58:21.975+000016545: debug : virNetServerClientCalculateHandleMode:152 : tls=(nil) hs=-1, rx=0x1f6ab90 tx=(nil)
>2013-02-26 08:58:21.975+000016545: debug : virNetServerClientCalculateHandleMode:183 : mode=1
>2013-02-26 08:58:21.975+000016545: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=16 events=1
>2013-02-26 08:58:21.975+000016545: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 1267492960
>2013-02-26 08:58:21.975+000016545: debug : virNetServerClientDispatchRead:875 : RPC_SERVER_CLIENT_MSG_RX: client=0x1f67700 len=56 prog=536903814 vers=1 proc=12 type=0 status=0 serial=5
>2013-02-26 08:58:21.975+000016545: debug : virKeepAliveCheckMessage:384 : ka=0x1f69060, client=0x1f67700, msg=0x1f6ab90
>2013-02-26 08:58:21.975+000016545: debug : virEventPollUpdateTimeout:254 : EVENT_POLL_UPDATE_TIMEOUT: timer=11 frequency=3000
>2013-02-26 08:58:21.975+000016545: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 1267492960
>2013-02-26 08:58:21.975+000016545: debug : virObjectRef:168 : OBJECT_REF: obj=0x1f67700
>2013-02-26 08:58:21.975+000016545: debug : virN2013-02-26 08:58:22.247+000016545: debug : virEventPollDispatchHandles:483 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1
>2013-02-26 08:58:22.247+000016550: debug : virNetMessageEncodePayload:358 : Encode length as 164
>2013-02-26 08:58:22.247+000016545: debug : virEventPollDispatchHandles:469 : i=1 w=2
>2013-02-26 08:58:22.247+000016550: debug : virNetServerClientSendMessageLocked:1119 : msg=0x1f661d0 proc=261 len=164 offset=0
>2013-02-26 08:58:22.247+000016545: debug : virEventPollDispatchHandles:469 : i=2 w=3
>2013-02-26 08:58:22.247+000016550: debug : virNetServerClientSendMessageLocked:1127 : RPC_SERVER_CLIENT_MSG_TX_QUEUE: client=0x1f67150 len=164 prog=536903814 vers=1 proc=261 type=1 status=1 serial=14
>2013-02-26 08:58:22.247+000016545: debug : virEventPollDispatchHandles:469 : i=3 w=4
>2013-02-26 08:58:22.247+000016545: debug : virEventPollDispatchHandles:469 : i=4 w=5
>2013-02-26 08:58:22.247+000016550: debug : virNetServerClientCalculateHandleMode:152 : tls=(nil) hs=-1, rx=0x1f68ff0 tx=0x1f661d0
>2013-02-26 08:58:22.247+000016545: debug : virEventPollDispatchHandles:469 : i=5 w=6
>2013-02-26 08:58:22.247+000016550: debug : virNetServerClientCalculateHandleMode:183 : mode=3
>2013-02-26 08:58:22.247+000016545: debug : virEventPollDispatchHandles:483 : EVENT_POLL_DISPATCH_HANDLE: watch=6 events=1
>2013-02-26 08:58:22.247+000016550: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=12 events=3
>2013-02-26 08:58:22.247+000016550: debug : virEventPollInterruptLocked:701 : Interrupting
>: Cleanup 11
>2013-02-26 08:58:21.975+000016549: debug : virObjectNew:110 : OBJECT_NEW: obj=0x7fb4103e2720 classname=virDomain
>2013-02-26 08:58:21.975+000016545: debug : virEventPollCleanupHandles:549 : Cleanup 14
>2013-02-26 08:58:21.975+000016549: debug : virObjectRef:168 : OBJECT_REF: obj=0x7fb410074e50
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=0 w=1, f=7 e=1 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=1 w=2, f=9 e=1 d=0
>2013-02-26 08:58:21.975+000016549: debug : virDomainDestroy:2172 : dom=0x7fb4103e2720, (VM: name=aaa, uuid=f33d9914-4add-c75f-3502-3cd73ea3b795)
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=2 w=3, f=12 e=1 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=3 w=4, f=13 e=1 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=4 w=5, f=6 e=1 d=0
>2013-02-26 08:58:21.975+000016549: debug : qemuProcessKill:4104 : vm=aaa pid=17318 flags=1
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=5 w=6, f=14 e=1 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=6 w=7, f=17 e=1 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=7 w=8, f=19 e=1 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=8 w=9, f=22 e=1 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=9 w=12, f=25 e=1 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=10 w=13, f=30 e=25 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=11 w=14, f=27 e=25 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=12 w=15, f=26 e=1 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=13 w=16, f=33 e=1 d=0
>2013-02-26 08:58:21.975+000016545: debug : virEventPollCalculateTimeout:320 : Calculate expiry of 11 timers
>2013-02-26 08:58:21.975+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869104826
>2013-02-26 08:58:21.975+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869104323
>2013-02-26 08:58:21.975+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869102621
>2013-02-26 08:58:21.975+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869103634
>2013-02-26 08:58:21.975+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869104975
>2013-02-26 08:58:21.975+000016545: debug : virEventPollCalculateTimeout:346 : Timeout at 1361869102621 due in 646 ms
>2013-02-26 08:58:21.975+000016545: debug : virEventPollRunOnce:614 : EVENT_POLL_RUN: nhandles=14 timeout=646
>2013-02-26 08:58:21.976+000016545: debug : virEventPollRunOnce:625 : Poll got 1 event(s)
>2013-02-26 08:58:21.976+000016545: debug : virEventPollDispatchTimeouts:410 : Dispatch 11
>2013-02-26 08:58:21.976+000016545: debug : virEventPollDispatchHandles:455 : Dispatch 14
>2013-02-26 08:58:21.976+000016545: debug : virEventPollDispatchHandles:469 : i=0 w=1
>2013-02-26 08:58:21.976+000016545: debug : virEventPollDispatchHandles:469 : i=1 w=2
>2013-02-26 08:58:21.976+000016545: debug : virEventPollDispatchHandles:469 : i=2 w=3
>2013-02-26 08:58:21.976+000016545: debug : virEventPollDispatchHandles:469 : i=3 w=4
>2013-02-26 08:58:21.976+000016545: debug : virEventPollDispatchHandles:469 : i=4 w=5
>2013-02-26 08:58:21.976+000016545: debug : virEventPollDispatchHandles:469 : i=5 w=6
>2013-02-26 08:58:21.976+000016545: debug : virEventPollDispatchHandles:469 : i=6 w=7
>2013-02-26 08:58:21.976+000016545: debug : virEventPollDispatchHandles:469 : i=7 w=8
>2013-02-26 08:58:21.976+000016545: debug : virEventPollDispatchHandles:469 : i=8 w=9
>2013-02-26 08:58:21.976+000016545: debug : virEventPollDispatchHandles:469 : i=9 w=12
>2013-02-26 08:58:21.976+000016545: debug : virEventPollDispatchHandles:469 : i=10 w=13
>2013-02-26 08:58:21.976+000016545: debug : virEventPollDispatchHandles:483 : EVENT_POLL_DISPATCH_HANDLE: watch=13 events=1
>2013-02-26 08:58:21.976+000016545: debug : virObjectRef:168 : OBJECT_REF: obj=0x7fb420003390
>2013-02-26 08:58:21.976+000016545: debug : qemuMonitorIOProcess:353 : QEMU_MONITOR_IO_PROCESS: mon=0x7fb420003390 buf={"timestamp": {"seconds": 1361869101, "microseconds": 976420}, "event": "SHUTDOWN"}
> len=85
>2013-02-26 08:58:21.976+000016545: debug : qemuMonitorJSONIOProcessLine:152 : Line [{"timestamp": {"seconds": 1361869101, "microseconds": 976420}, "event": "SHUTDOWN"}]
>2013-02-26 08:58:21.976+000016545: debug : virJSONValueFromString:975 : string={"timestamp": {"seconds": 1361869101, "microseconds": 976420}, "event": "SHUTDOWN"}
>2013-02-26 08:58:21.976+000016545: debug : virJSONParserHandleStartMap:852 : parser=0x7fff0ec334b0
>2013-02-26 08:58:21.976+000016545: debug : virJSONParserHandleMapKey:833 : parser=0x7fff0ec334b0 key=0x1f65cc2
>2013-02-26 08:58:21.976+000016545: debug : virJSONParserHandleStartMap:852 : parser=0x7fff0ec334b0
>2013-02-26 08:58:21.976+000016545: debug : virJSONParserHandleMapKey:833 : parser=0x7fff0ec334b0 key=0x1f65cd0
>2013-02-26 08:58:21.976+000016545: debug : virJSONParserHandleNumber:792 : parser=0x7fff0ec334b0 str=(null)
>2013-02-26 08:58:21.976+000016545: debug : virJSONParserHandleMapKey:833 : parser=0x7fff0ec334b0 key=0x1f65ce7
>2013-02-26 08:58:21.976+000016545: debug : virJSONParserHandleNumber:792 : parser=0x7fff0ec334b0 str=(null)
>2013-02-26 08:58:21.976+000016545: debug : virJSONParserHandleEndMap:881 : parser=0x7fff0ec334b0
>2013-02-26 08:58:21.976+000016545: debug : virJSONParserHandleMapKey:833 : parser=0x7fff0ec334b0 key=0x1f65d00
>2013-02-26 08:58:21.976+000016545: debug : virJSONParserHandleString:813 : parser=0x7fff0ec334b0 str=0x1f65d09
>2013-02-26 08:58:21.976+000016545: debug : virJSONParserHandleEndMap:881 : parser=0x7fff0ec334b0
>2013-02-26 08:58:21.976+000016545: debug : virJSONValueFromString:1019 : result=0x1f42d10
>2013-02-26 08:58:21.976+000016545: debug : qemuMonitorJSONIOProcessLine:167 : QEMU_MONITOR_RECV_EVENT: mon=0x7fb420003390 event={"timestamp": {"seconds": 1361869101, "microseconds": 976420}, "event": "SHUTDOWN"}
>2013-02-26 08:58:21.976+000016545: debug : qemuMonitorJSONIOProcessEvent:124 : mon=0x7fb420003390 obj=0x1f42d10
>2013-02-26 08:58:21.976+000016545: debug : qemuMonitorJSONIOProcessEvent:138 : handle SHUTDOWN handler=0x4af1d0 data=(nil)
>2013-02-26 08:58:21.976+000016545: debug : qemuMonitorEmitShutdown:987 : mon=0x7fb420003390
>2013-02-26 08:58:21.976+000016545: debug : virObjectRef:168 : OBJECT_REF: obj=0x7fb420003390
>2013-02-26 08:58:21.976+000016545: debug : qemuProcessHandleShutdown:638 : vm=0x7fb4380d5910
>2013-02-26 08:58:22.176+000016549: debug : virObjectRef:168 : OBJECT_REF: obj=0x7fb4380d5910
>2013-02-26 08:58:22.176+000016549: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7fb4380d5910
>2013-02-26 08:58:22.176+000016549: debug : virObjectRef:168 : OBJECT_REF: obj=0x7fb4380d5910
>2013-02-26 08:58:22.176+000016545: debug : qemuProcessHandleShutdown:655 : Transitioned guest aaa to shutdown state
>2013-02-26 08:58:22.246+000016545: debug : virFileClose:72 : Closed fd 36
>2013-02-26 08:58:22.247+000016545: debug : qemuAgentNotifyEvent:1263 : mon=0x7fb420004680 event=1
>2013-02-26 08:58:22.247+000016545: warning : qemuAgentNotifyEvent:1274 : Received unexpected event 1
>2013-02-26 08:58:22.247+000016545: debug : qemuProcessKill:4104 : vm=aaa pid=17318 flags=2
>2013-02-26 08:58:22.247+000016545: debug : virEventPollUpdateTimeout:254 : EVENT_POLL_UPDATE_TIMEOUT: timer=5 frequency=0
>2013-02-26 08:58:22.247+000016545: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 1267492960
>2013-02-26 08:58:22.247+000016545: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7fb420003390
>2013-02-26 08:58:22.247+000016545: debug : qemuMonitorJSONIOProcess:223 : Total used 85 bytes out of 85 available in buffer
>2013-02-26 08:58:22.247+000016545: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=13 events=13
>2013-02-26 08:58:22.247+000016545: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 1267492960
>2013-02-26 08:58:22.247+000016545: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7fb420003390
>2013-02-26 08:58:22.247+000016545: debug : virEventPollDispatchHandles:469 : i=11 w=14
>2013-02-26 08:58:22.247+000016545: debug : virEventPollDispatchHandles:469 : i=12 w=15
>2013-02-26 08:58:22.247+000016545: debug : virEventPollDispatchHandles:469 : i=13 w=16
>2013-02-26 08:58:22.247+000016545: debug : virEventPollCleanupTimeouts:501 : Cleanup 11
>2013-02-26 08:58:22.247+000016545: debug : virEventPollCleanupHandles:549 : Cleanup 14
>2013-02-26 08:58:22.247+000016545: debug : virEventRunDefaultImpl:244 : running default event implementation
>2013-02-26 08:58:22.247+000016545: debug : virEventPollCleanupTimeouts:501 : Cleanup 11
>2013-02-26 08:58:22.247+000016545: debug : virEventPollCleanupHandles:549 : Cleanup 14
>2013-02-26 08:58:22.247+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=0 w=1, f=7 e=1 d=0
>2013-02-26 08:58:22.247+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=1 w=2, f=9 e=1 d=0
>2013-02-26 08:58:22.247+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=2 w=3, f=12 e=1 d=0
>2013-02-26 08:58:22.247+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=3 w=4, f=13 e=1 d=0
>2013-02-26 08:58:22.247+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=4 w=5, f=6 e=1 d=0
>2013-02-26 08:58:22.247+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=5 w=6, f=14 e=1 d=0
>2013-02-26 08:58:22.247+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=6 w=7, f=17 e=1 d=0
>2013-02-26 08:58:22.247+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=7 w=8, f=19 e=1 d=0
>2013-02-26 08:58:22.247+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=8 w=9, f=22 e=1 d=0
>2013-02-26 08:58:22.247+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=9 w=12, f=25 e=1 d=0
>2013-02-26 08:58:22.247+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=10 w=13, f=30 e=25 d=0
>2013-02-26 08:58:22.247+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=11 w=14, f=27 e=25 d=0
>2013-02-26 08:58:22.247+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=12 w=15, f=26 e=1 d=0
>2013-02-26 08:58:22.247+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=13 w=16, f=33 e=1 d=0
>2013-02-26 08:58:22.247+000016545: debug : virEventPollCalculateTimeout:320 : Calculate expiry of 11 timers
>2013-02-26 08:58:22.247+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869104826
>2013-02-26 08:58:22.247+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869104323
>2013-02-26 08:58:22.247+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869102247
>2013-02-26 08:58:22.247+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869102621
>2013-02-26 08:58:22.247+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869103634
>2013-02-26 08:58:22.247+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869104975
>2013-02-26 08:58:22.247+000016545: debug : virEventPollCalculateTimeout:346 : Timeout at 1361869102247 due in 0 ms
>2013-02-26 08:58:22.247+000016545: debug : virEventPollRunOnce:614 : EVENT_POLL_RUN: nhandles=14 timeout=0
>2013-02-26 08:58:22.247+000016545: debug : virEventPollRunOnce:625 : Poll got 4 event(s)
>2013-02-26 08:58:22.247+000016545: debug : virEventPollDispatchTimeouts:410 : Dispatch 11
>2013-02-26 08:58:22.247+000016545: debug : virEventPollDispatchTimeouts:433 : EVENT_POLL_DISPATCH_TIMEOUT: timer=5
>2013-02-26 08:58:22.247+000016545: debug : virEventPollUpdateTimeout:254 : EVENT_POLL_UPDATE_TIMEOUT: timer=5 frequency=-1
>2013-02-26 08:58:22.247+000016545: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 1267492960
>2013-02-26 08:58:22.247+000016545: debug : virObjectNew:110 : OBJECT_NEW: obj=0x1f67ab0 classname=virDomain
>2013-02-26 08:58:22.247+000016545: debug : virObjectRef:168 : OBJECT_REF: obj=0x7fb42c000a70
>2013-02-26 08:58:22.247+000016545: debug : remoteRelayDomainEventLifecycle:128 : Relaying domain lifecycle event 6 0
>2013-02-26 08:58:22.247+000016545: debug : virNetMessageNew:45 : msg=0x1f66470 tracked=0
>2013-02-26 08:58:22.247+000016545: debug : virNetMessageEncodePayload:358 : Encode length as 64
>2013-02-26 08:58:22.247+000016545: debug : remoteDispatchDomainEventSend:3237 : Queue event 107 64
>2013-02-26 08:58:22.247+000016545: debug : virNetServerClientSendMessageLocked:1119 : msg=0x1f66470 proc=107 len=64 offset=0
>2013-02-26 08:58:22.247+000016545: debug : virNetServerClientSendMessageLocked:1127 : RPC_SERVER_CLIENT_MSG_TX_QUEUE: client=0x1f69460 len=64 prog=536903814 vers=1 proc=107 type=2 status=0 serial=1
>2013-02-26 08:58:22.247+000016545: debug : virNetServerClientCalculateHandleMode:152 : tls=(nil) hs=-1, rx=0x1f678c0 tx=0x1f66470
>2013-02-26 08:58:22.247+000016545: debug : virNetServerClientCalculateHandleMode:183 : mode=3
>2013-02-26 08:58:22.247+000016545: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=9 events=3
>2013-02-26 08:58:22.247+000016545: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 1267492960
>2013-02-26 08:58:22.247+000016545: debug : virDomainFree:2281 : dom=0x1f67ab0, (VM: name=aaa, uuid=f33d9914-4add-c75f-3502-3cd73ea3b795)
>2013-02-26 08:58:22.247+000016545: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x1f67ab0
>2013-02-26 08:58:22.247+000016545: debug : virObjectUnref:137 : OBJECT_DISPOSE: obj=0x1f67ab0
>2013-02-26 08:58:22.247+000016545: debug : virDomainDispose:225 : release domain 0x1f67ab0 aaa f33d9914-4add-c75f-3502-3cd73ea3b795
>2013-02-26 08:58:22.247+000016545: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7fb42c000a70
>2013-02-26 08:58:22.247+000016545: debug : virEventPollDispatchHandles:455 : Dispatch 14
>2013-02-26 08:58:22.247+000016545: debug : virEventPollDispatchHandles:469 : i=0 w=1
>2013-02-26 08:58:22.247+000016545: debug : virEventPollDispatchHandles:469 : i=1 w=2
>2013-02-26 08:58:22.247+000016545: debug : virEventPollDispatchHandles:469 : i=2 w=3
>2013-02-26 08:58:22.247+000016545: debug : virEventPollDispatchHandles:469 : i=3 w=4
>2013-02-26 08:58:22.247+000016545: debug : virEventPollDispatchHandles:469 : i=4 w=5
>2013-02-26 08:58:22.247+000016545: debug : virEventPollDispatchHandles:469 : i=5 w=6
>2013-02-26 08:58:22.247+000016545: debug : virEventPollDispatchHandles:483 : EVENT_POLL_DISPATCH_HANDLE: watch=6 events=1
>2013-02-26 08:58:22.247+000016545: debug : virNetlinkEventCallback:346 : dispatching to max 0 clients, called from event watch 6
>2013-02-26 08:58:22.247+000016545: debug : virNetlinkEventCallback:359 : event not handled.
>2013-02-26 08:58:22.247+000016545: debug : virEventPollDispatchHandles:469 : i=6 w=7
>2013-02-26 08:58:22.247+000016545: debug : virEventPollDispatchHandles:483 : EVENT_POLL_DISPATCH_HANDLE: watch=7 events=1
>2013-02-26 08:58:22.247+000016545: debug : udevEventHandleCallback:1467 : udev action: 'remove'
>2013-02-26 08:58:22.247+000016545: debug : udevRemoveOneDevice:1218 : Failed to find device to remove that has udev name '/sys/devices/virtual/net/vnet0/queues/rx-0'
>2013-02-26 08:58:22.247+000016545: debug : virEventPollDispatchHandles:469 : i=7 w=8
>2013-02-26 08:58:22.247+000016545: debug : virEventPollDispatchHandles:469 : i=8 w=9
>2013-02-26 08:58:22.247+000016545: debug : virEventPollDispatchHandles:469 : i=9 w=12
>2013-02-26 08:58:22.247+000016545: debug : virEventPollDispatchHandles:469 : i=10 w=13
>2013-02-26 08:58:22.247+000016545: debug : virEventPollDispatchHandles:483 : EVENT_POLL_DISPATCH_HANDLE: watch=13 events=9
>2013-02-26 08:58:22.247+000016545: debug : virObjectRef:168 : OBJECT_REF: obj=0x7fb420003390
>2013-02-26 08:58:22.247+000016545: error : qemuMonitorIO:613 : åé¨éè¯¯ End of file from monitor
>2013-02-26 08:58:22.247+000016545: debug : qemuMonitorIO:646 : Error on monitor åé¨éè¯¯ End of file from monitor
>2013-02-26 08:58:22.247+000016545: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=13 events=12
>2013-02-26 08:58:22.247+000016545: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 1267492960
>2013-02-26 08:58:22.247+000016545: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7fb420003390
>2013-02-26 08:58:22.247+000016545: debug : qemuMonitorIO:669 : Triggering EOF callback
>2013-02-26 08:58:22.247+000016545: debug : qemuProcessHandleMonitorEOF:283 : Received EOF on 0x7fb4380d5910 'aaa'
>2013-02-26 08:58:22.247+000016545: debug : qemuProcessHandleMonitorEOF:291 : Domain is being destroyed, EOF is expected
>2013-02-26 08:58:22.247+000016545: debug : virEventPollDispatchHandles:469 : i=11 w=14
>2013-02-26 08:58:22.247+000016545: debug : virEventPollDispatchHandles:483 : EVENT_POLL_DISPATCH_HANDLE: watch=14 events=9
>2013-02-26 08:58:22.247+000016545: debug : virObjectRef:168 : OBJECT_REF: obj=0x7fb420004680
>2013-02-26 08:58:22.247+000016545: error : qemuAgentIO:642 : åé¨éè¯¯ End of file from monitor
>2013-02-26 08:58:22.247+000016545: debug : qemuAgentIO:675 : Error on monitor åé¨éè¯¯ End of file from monitor
>2013-02-26 08:58:22.247+000016545: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=14 events=12
>2013-02-26 08:58:22.247+000016545: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 1267492960
>2013-02-26 08:58:22.247+000016545: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7fb420004680
>2013-02-26 08:58:22.247+000016545: debug : qemuAgentIO:698 : Triggering EOF callback
>2013-02-26 08:58:22.247+000016545: debug : qemuProcessHandleAgentEOF:125 : Received EOF from agent on 0x7fb4380d5910 'aaa'
>2013-02-26 08:58:22.247+000016545: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7fb420004680
>2013-02-26 08:58:22.247+000016545: debug : qemuAgentClose:814 : mon=0x7fb420004680
>2013-02-26 08:58:22.247+000016545: debug : virEventPollRemoveHandle:175 : EVENT_POLL_REMOVE_HANDLE: watch=14
>2013-02-26 08:58:22.247+000016545: debug : virEventPollRemoveHandle:188 : mark delete 11 27
>2013-02-26 08:58:22.247+000016545: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 1267492960
>2013-02-26 08:58:22.247+000016545: debug : virFileClose:72 : Closed fd 27
>2013-02-26 08:58:22.247+000016545: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7fb420004680
>2013-02-26 08:58:22.247+000016545: debug : virEventPollDispatchHandles:469 : i=12 w=15
>2013-02-26 08:58:22.247+000016545: debug : virEventPollDispatchHandles:469 : i=13 w=16
>2013-02-26 08:58:22.247+000016545: debug : virEventPollCleanupTimeouts:501 : Cleanup 11
>2013-02-26 08:58:22.247+000016545: debug : virEventPollCleanupHandles:549 : Cleanup 14
>2013-02-26 08:58:22.247+000016545: debug : virEventPollCleanupHandles:562 : EVENT_POLL_PURGE_HANDLE: watch=14
>2013-02-26 08:58:22.247+000016545: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7fb420004680
>2013-02-26 08:58:22.247+000016550: debug : qemuAgentSend:900 : Send command resulted in error åé¨éè¯¯ End of file from monitor
>2013-02-26 08:58:22.247+000016545: debug : virObjectUnref:137 : OBJECT_DISPOSE: obj=0x7fb420004680
>2013-02-26 08:58:22.247+000016545: debug : qemuAgentDispose:169 : mon=0x7fb420004680
>2013-02-26 08:58:22.247+000016550: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=14 events=12
>2013-02-26 08:58:22.247+000016550: debug : virEventPollInterruptLocked:701 : Interrupting
>2013-02-26 08:58:22.247+000016545: debug : qemuProcessHandleAgentDestroy:171 : Received destroy agent=0x7fb420004680 vm=0x7fb4380d5910
>2013-02-26 08:58:22.247+000016550: debug : qemuAgentCommand:1023 : Receive command reply ret=-1 rxObject=(nil)
>2013-02-26 08:58:22.247+000016545: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7fb4380d5910
>2013-02-26 08:58:22.247+000016550: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7fb420004680
>2013-02-26 08:58:22.247+000016545: debug : virEventRunDefaultImpl:244 : running default event implementation
>2013-02-26 08:58:22.247+000016550: debug : qemuDomainObjEndJob:937 : Stopping job: modify (async=none)
>2013-02-26 08:58:22.247+000016545: debug : virEventPollCleanupTimeouts:501 : Cleanup 11
>2013-02-26 08:58:22.247+000016545: debug : virEventPollCleanupHandles:549 : Cleanup 13
>2013-02-26 08:58:22.247+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=0 w=1, f=7 e=1 d=0
>2013-02-26 08:58:22.247+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=1 w=2, f=9 e=1 d=0
>2013-02-26 08:58:22.247+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=2 w=3, f=12 e=1 d=0
>2013-02-26 08:58:22.247+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=3 w=4, f=13 e=1 d=0
>2013-02-26 08:58:22.247+000016550: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7fb4380d5910
>2013-02-26 08:58:22.247+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=4 w=5, f=6 e=1 d=0
>2013-02-26 08:58:22.247+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=5 w=6, f=14 e=1 d=0
>2013-02-26 08:58:22.247+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=6 w=7, f=17 e=1 d=0
>2013-02-26 08:58:22.247+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=7 w=8, f=19 e=1 d=0
>2013-02-26 08:58:22.247+000016550: debug : virDomainFree:2281 : dom=0x7fb42c0c2420, (VM: name=aaa, uuid=f33d9914-4add-c75f-3502-3cd73ea3b795)
>2013-02-26 08:58:22.247+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=8 w=9, f=22 e=5 d=0
>2013-02-26 08:58:22.247+000016550: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7fb42c0c2420
>2013-02-26 08:58:22.247+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=9 w=12, f=25 e=1 d=0
>2013-02-26 08:58:22.247+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=10 w=13, f=30 e=24 d=0
>2013-02-26 08:58:22.247+000016550: debug : virObjectUnref:137 : OBJECT_DISPOSE: obj=0x7fb42c0c2420
>2013-02-26 08:58:22.247+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=11 w=15, f=26 e=1 d=0
>2013-02-26 08:58:22.247+000016545: debug : virEventPollMakePollFDs:378 : Prepare n=12 w=16, f=33 e=1 d=0
>2013-02-26 08:58:22.247+000016550: debug : virDomainDispose:225 : release domain 0x7fb42c0c2420 aaa f33d9914-4add-c75f-3502-3cd73ea3b795
>2013-02-26 08:58:22.247+000016545: debug : virEventPollCalculateTimeout:320 : Calculate expiry of 11 timers
>2013-02-26 08:58:22.247+000016550: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7fb4180008c0
>2013-02-26 08:58:22.247+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869104826
>2013-02-26 08:58:22.247+000016546: debug : qemuDomainObjBeginJobInternal:808 : Starting job: modify (async=none)
>2013-02-26 08:58:22.247+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869104323
>2013-02-26 08:58:22.247+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869102621
>2013-02-26 08:58:22.247+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869103634
>2013-02-26 08:58:22.247+000016545: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1361869104975
>2013-02-26 08:58:22.247+000016546: debug : virObjectRef:168 : OBJECT_REF: obj=0x7fb420004680
>2013-02-26 08:58:22.247+000016545: debug : virEventPollCalculateTimeout:346 : Timeout at 1361869102621 due in 374 ms
>2013-02-26 08:58:22.247+000016545: debug : virEventPollRunOnce:614 : EVENT_POLL_RUN: nhandles=13 timeout=374
>2013-02-26 08:58:22.247+000016545: debug : virEventPollRunOnce:625 : Poll got 5 event(s)
>2013-02-26 08:58:22.247+000016546: debug : qemuAgentGuestSync:948 : Sending guest-sync command with ID: 1361869102247
>2013-02-26 08:58:22.247+000016545: debug : virEventPollDispatchTimeouts:410 : Dispatch 11
>2013-02-26 08:58:22.247+000016546: debug : qemuAgentSend:866 : Attempt to send command while error is set in
>2013-02-26 08:58:22.247+000016545: debug : virEventPollDispatchHandles:455 : Dispatch 13
>2013-02-26 08:58:22.247+000016545: debug : virEventPollDispatchHandles:469 : i=0 w=1
>2013-02-26 08:58:22.247+000016550: debug : virNetServerProgramSendError:150 : prog=536903814 ver=1 proc=261 type=1 serial=14 msg=0x1f661d0 rerr=0x7fb44322fb80
>
>
>     ====== end of log =====
>

Actions: View

Attachments on bug 915636: 702714 | 703233 | 703235 | 703268