2013-04-11 14:12:00.606+0000: 1573: debug : virEventPollCleanupHandles:554 : Cleanup 4
2013-04-11 14:12:00.606+0000: 1573: debug : virEventRunDefaultImpl:244 : running default event implementation
2013-04-11 14:12:00.606+0000: 1573: debug : virEventPollCleanupTimeouts:506 : Cleanup 1
2013-04-11 14:12:00.606+0000: 1573: debug : virEventPollCleanupHandles:554 : Cleanup 4
2013-04-11 14:12:00.606+0000: 1573: debug : virEventPollMakePollFDs:383 : Prepare n=0 w=1, f=4 e=1 d=0
2013-04-11 14:12:00.606+0000: 1573: debug : virEventPollMakePollFDs:383 : Prepare n=1 w=2, f=8 e=1 d=0
2013-04-11 14:12:00.606+0000: 1573: debug : virEventPollMakePollFDs:383 : Prepare n=2 w=3, f=10 e=1 d=0
2013-04-11 14:12:00.606+0000: 1573: debug : virEventPollMakePollFDs:383 : Prepare n=3 w=4, f=11 e=0 d=0
2013-04-11 14:12:00.606+0000: 1573: debug : virEventPollCalculateTimeout:325 : Calculate expiry of 1 timers
2013-04-11 14:12:00.606+0000: 1573: debug : virEventPollCalculateTimeout:351 : Timeout at 0 due in -1 ms
2013-04-11 14:12:00.606+0000: 1573: debug : virEventPollRunOnce:619 : EVENT_POLL_RUN: nhandles=3 timeout=-1
2013-04-11 14:12:00.606+0000: 1573: debug : virEventPollRunOnce:630 : Poll got 1 event(s)
2013-04-11 14:12:00.606+0000: 1573: debug : virEventPollDispatchTimeouts:415 : Dispatch 1
2013-04-11 14:12:00.606+0000: 1573: debug : virEventPollDispatchHandles:460 : Dispatch 3
2013-04-11 14:12:00.606+0000: 1573: debug : virEventPollDispatchHandles:474 : i=0 w=1
2013-04-11 14:12:00.606+0000: 1573: debug : virEventPollDispatchHandles:488 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1
2013-04-11 14:12:00.606+0000: 1573: debug : virEventPollDispatchHandles:474 : i=1 w=2
2013-04-11 14:12:00.606+0000: 1573: debug : virEventPollDispatchHandles:474 : i=2 w=3
2013-04-11 14:12:00.606+0000: 1573: debug : virEventPollCleanupTimeouts:506 : Cleanup 1
2013-04-11 14:12:00.606+0000: 1573: debug : virEventPollCleanupHandles:554 : Cleanup 4
2013-04-11 14:12:00.606+0000: 1573: debug : virEventRunDefaultImpl:244 : running default event implementation
2013-04-11 14:12:00.606+0000: 1573: debug : virEventPollCleanupTimeouts:506 : Cleanup 1
2013-04-11 14:12:00.606+0000: 1573: debug : virEventPollCleanupHandles:554 : Cleanup 4
2013-04-11 14:12:00.606+0000: 1573: debug : virEventPollMakePollFDs:383 : Prepare n=0 w=1, f=4 e=1 d=0
2013-04-11 14:12:00.606+0000: 1573: debug : virEventPollMakePollFDs:383 : Prepare n=1 w=2, f=8 e=1 d=0
2013-04-11 14:12:00.606+0000: 1573: debug : virEventPollMakePollFDs:383 : Prepare n=2 w=3, f=10 e=1 d=0
2013-04-11 14:12:00.606+0000: 1573: debug : virEventPollMakePollFDs:383 : Prepare n=3 w=4, f=11 e=0 d=0
2013-04-11 14:12:00.606+0000: 1573: debug : virEventPollCalculateTimeout:325 : Calculate expiry of 1 timers
2013-04-11 14:12:00.606+0000: 1573: debug : virEventPollCalculateTimeout:351 : Timeout at 0 due in -1 ms
2013-04-11 14:12:00.606+0000: 1573: debug : virEventPollRunOnce:619 : EVENT_POLL_RUN: nhandles=3 timeout=-1
2013-04-11 14:12:00.606+0000: 1573: debug : virEventPollRunOnce:630 : Poll got 1 event(s)
2013-04-11 14:12:00.606+0000: 1573: debug : virEventPollDispatchTimeouts:415 : Dispatch 1
2013-04-11 14:12:00.606+0000: 1573: debug : virEventPollDispatchHandles:460 : Dispatch 3
2013-04-11 14:12:00.606+0000: 1573: debug : virEventPollDispatchHandles:474 : i=0 w=1
2013-04-11 14:12:00.606+0000: 1573: debug : virEventPollDispatchHandles:488 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1
2013-04-11 14:12:00.606+0000: 1573: debug : virEventPollDispatchHandles:474 : i=1 w=2
2013-04-11 14:12:00.606+0000: 1573: debug : virEventPollDispatchHandles:474 : i=2 w=3
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollCleanupTimeouts:506 : Cleanup 1
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollCleanupHandles:554 : Cleanup 4
2013-04-11 14:12:00.607+0000: 1573: debug : virEventRunDefaultImpl:244 : running default event implementation
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollCleanupTimeouts:506 : Cleanup 1
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollCleanupHandles:554 : Cleanup 4
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollMakePollFDs:383 : Prepare n=0 w=1, f=4 e=1 d=0
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollMakePollFDs:383 : Prepare n=1 w=2, f=8 e=1 d=0
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollMakePollFDs:383 : Prepare n=2 w=3, f=10 e=1 d=0
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollMakePollFDs:383 : Prepare n=3 w=4, f=11 e=0 d=0
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollCalculateTimeout:325 : Calculate expiry of 1 timers
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollCalculateTimeout:351 : Timeout at 0 due in -1 ms
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollRunOnce:619 : EVENT_POLL_RUN: nhandles=3 timeout=-1
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollRunOnce:630 : Poll got 1 event(s)
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollDispatchTimeouts:415 : Dispatch 1
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollDispatchHandles:460 : Dispatch 3
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollDispatchHandles:474 : i=0 w=1
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollDispatchHandles:488 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollDispatchHandles:474 : i=1 w=2
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollDispatchHandles:474 : i=2 w=3
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollCleanupTimeouts:506 : Cleanup 1
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollCleanupHandles:554 : Cleanup 4
2013-04-11 14:12:00.607+0000: 1573: debug : virEventRunDefaultImpl:244 : running default event implementation
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollCleanupTimeouts:506 : Cleanup 1
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollCleanupHandles:554 : Cleanup 4
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollMakePollFDs:383 : Prepare n=0 w=1, f=4 e=1 d=0
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollMakePollFDs:383 : Prepare n=1 w=2, f=8 e=1 d=0
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollMakePollFDs:383 : Prepare n=2 w=3, f=10 e=1 d=0
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollMakePollFDs:383 : Prepare n=3 w=4, f=11 e=0 d=0
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollCalculateTimeout:325 : Calculate expiry of 1 timers
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollCalculateTimeout:351 : Timeout at 0 due in -1 ms
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollRunOnce:619 : EVENT_POLL_RUN: nhandles=3 timeout=-1
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollRunOnce:630 : Poll got 1 event(s)
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollDispatchTimeouts:415 : Dispatch 1
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollDispatchHandles:460 : Dispatch 3
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollDispatchHandles:474 : i=0 w=1
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollDispatchHandles:488 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollDispatchHandles:474 : i=1 w=2
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollDispatchHandles:474 : i=2 w=3
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollCleanupTimeouts:506 : Cleanup 1
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollCleanupHandles:554 : Cleanup 4
2013-04-11 14:12:00.607+0000: 1573: debug : virEventRunDefaultImpl:244 : running default event implementation
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollCleanupTimeouts:506 : Cleanup 1
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollCleanupHandles:554 : Cleanup 4
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollMakePollFDs:383 : Prepare n=0 w=1, f=4 e=1 d=0
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollMakePollFDs:383 : Prepare n=1 w=2, f=8 e=1 d=0
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollMakePollFDs:383 : Prepare n=2 w=3, f=10 e=1 d=0
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollMakePollFDs:383 : Prepare n=3 w=4, f=11 e=0 d=0
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollCalculateTimeout:325 : Calculate expiry of 1 timers
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollCalculateTimeout:351 : Timeout at 0 due in -1 ms
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollRunOnce:619 : EVENT_POLL_RUN: nhandles=3 timeout=-1
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollRunOnce:630 : Poll got 1 event(s)
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollDispatchTimeouts:415 : Dispatch 1
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollDispatchHandles:460 : Dispatch 3
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollDispatchHandles:474 : i=0 w=1
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollDispatchHandles:488 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollDispatchHandles:474 : i=1 w=2
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollDispatchHandles:474 : i=2 w=3
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollCleanupTimeouts:506 : Cleanup 1
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollCleanupHandles:554 : Cleanup 4
2013-04-11 14:12:00.607+0000: 1573: debug : virEventRunDefaultImpl:244 : running default event implementation
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollCleanupTimeouts:506 : Cleanup 1
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollCleanupHandles:554 : Cleanup 4
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollMakePollFDs:383 : Prepare n=0 w=1, f=4 e=1 d=0
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollMakePollFDs:383 : Prepare n=1 w=2, f=8 e=1 d=0
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollMakePollFDs:383 : Prepare n=2 w=3, f=10 e=1 d=0
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollMakePollFDs:383 : Prepare n=3 w=4, f=11 e=0 d=0
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollCalculateTimeout:325 : Calculate expiry of 1 timers
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollCalculateTimeout:351 : Timeout at 0 due in -1 ms
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollRunOnce:619 : EVENT_POLL_RUN: nhandles=3 timeout=-1
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollRunOnce:630 : Poll got 1 event(s)
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollDispatchTimeouts:415 : Dispatch 1
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollDispatchHandles:460 : Dispatch 3
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollDispatchHandles:474 : i=0 w=1
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollDispatchHandles:488 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollDispatchHandles:474 : i=1 w=2
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollDispatchHandles:474 : i=2 w=3
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollCleanupTimeouts:506 : Cleanup 1
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollCleanupHandles:554 : Cleanup 4
2013-04-11 14:12:00.607+0000: 1573: debug : virEventRunDefaultImpl:244 : running default event implementation
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollCleanupTimeouts:506 : Cleanup 1
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollCleanupHandles:554 : Cleanup 4
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollMakePollFDs:383 : Prepare n=0 w=1, f=4 e=1 d=0
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollMakePollFDs:383 : Prepare n=1 w=2, f=8 e=1 d=0
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollMakePollFDs:383 : Prepare n=2 w=3, f=10 e=1 d=0
2013-04-11 14:12:00.607+0000: 1573: debug : virEventPollMakePollFDs:383 : Prepare n=3 w=4, f=11 e=0 d=0
2013-04-11 14:12:00.608+0000: 1573: debug : virEventPollCalculateTimeout:325 : Calculate expiry of 1 timers
2013-04-11 14:12:00.608+0000: 1573: debug : virEventPollCalculateTimeout:351 : Timeout at 0 due in -1 ms
2013-04-11 14:12:00.608+0000: 1573: debug : virEventPollRunOnce:619 : EVENT_POLL_RUN: nhandles=3 timeout=-1
2013-04-11 14:12:00.608+0000: 1573: debug : virEventPollRunOnce:630 : Poll got 1 event(s)
2013-04-11 14:12:00.608+0000: 1573: debug : virEventPollDispatchTimeouts:415 : Dispatch 1
2013-04-11 14:12:00.608+0000: 1573: debug : virEventPollDispatchHandles:460 : Dispatch 3
2013-04-11 14:12:00.608+0000: 1573: debug : virEventPollDispatchHandles:474 : i=0 w=1
2013-04-11 14:12:00.608+0000: 1573: debug : virEventPollDispatchHandles:488 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1
2013-04-11 14:12:00.608+0000: 1573: debug : virEventPollDispatchHandles:474 : i=1 w=2
2013-04-11 14:12:00.608+0000: 1573: debug : virEventPollDispatchHandles:474 : i=2 w=3
2013-04-11 14:12:00.608+0000: 1573: debug : virEventPollCleanupTimeouts:506 : Cleanup 1
2013-04-11 14:12:00.608+0000: 1573: debug : virEventPollCleanupHandles:554 : Cleanup 4
2013-04-11 14:12:00.608+0000: 1573: debug : virEventRunDefaultImpl:244 : running default event implementation
2013-04-11 14:12:00.608+0000: 1573: debug : virEventPollCleanupTimeouts:506 : Cleanup 1
2013-04-11 14:12:00.608+0000: 1573: debug : virEventPollCleanupHandles:554 : Cleanup 4
2013-04-11 14:12:00.608+0000: 1573: debug : virEventPollMakePollFDs:383 : Prepare n=0 w=1, f=4 e=1 d=0
2013-04-11 14:12:00.608+0000: 1573: debug : virEventPollMakePollFDs:383 : Prepare n=1 w=2, f=8 e=1 d=0
2013-04-11 14:12:00.608+0000: 1573: debug : virEventPollMakePollFDs:383 : Prepare n=2 w=3, f=10 e=1 d=0
2013-04-11 14:12:00.608+0000: 1573: debug : virEventPollMakePollFDs:383 : Prepare n=3 w=4, f=11 e=0 d=0
2013-04-11 14:12:00.608+0000: 1573: debug : virEventPollCalculateTimeout:325 : Calculate expiry of 1 timers
2013-04-11 14:12:00.608+0000: 1573: debug : virEventPollCalculateTimeout:351 : Timeout at 0 due in -1 ms
2013-04-11 14:12:00.608+0000: 1573: debug : virEventPollRunOnce:619 : EVENT_POLL_RUN: nhandles=3 timeout=-1
2013-04-11 14:12:00.608+0000: 1573: debug : virEventPollRunOnce:630 : Poll got 1 event(s)
2013-04-11 14:12:00.608+0000: 1573: debug : virEventPollDispatchTimeouts:415 : Dispatch 1
2013-04-11 14:12:00.608+0000: 1573: debug : virEventPollDispatchHandles:460 : Dispatch 3
2013-04-11 14:12:00.608+0000: 1573: debug : virEventPollDispatchHandles:474 : i=0 w=1
2013-04-11 14:12:00.608+0000: 1573: debug : virEventPollDispatchHandles:488 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1
2013-04-11 14:12:00.608+0000: 1573: debug : virEventPollDispatchHandles:474 : i=1 w=2
2013-04-11 14:12:00.608+0000: 1573: debug : virEventPollDispatchHandles:474 : i=2 w=3
2013-04-11 14:12:00.608+0000: 1573: debug : virEventPollCleanupTimeouts:506 : Cleanup 1
2013-04-11 14:12:00.608+0000: 1573: debug : virEventPollCleanupHandles:554 : Cleanup 4
2013-04-11 14:12:00.608+0000: 1573: debug : virEventRunDefaultImpl:244 : running default event implementation
2013-04-11 14:12:00.608+0000: 1573: debug : virEventPollCleanupTimeouts:506 : Cleanup 1
2013-04-11 14:12:00.608+0000: 1573: debug : virEventPollCleanupHandles:554 : Cleanup 4
2013-04-11 14:12:00.608+0000: 1573: debug : virEventPollMakePollFDs:383 : Prepare n=0 w=1, f=4 e=1 d=0
2013-04-11 14:12:00.608+0000: 1573: debug : virEventPollMakePollFDs:383 : Prepare n=1 w=2, f=8 e=1 d=0
2013-04-11 14:12:00.608+0000: 1573: debug : virEventPollMakePollFDs:383 : Prepare n=2 w=3, f=10 e=1 d=0
2013-04-11 14:12:00.608+0000: 1573: debug : virEventPollMakePollFDs:383 : Prepare n=3 w=4, f=11 e=0 d=0
2013-04-11 14:12:00.608+0000: 1573: debug : virEventPollCalculateTimeout:325 : Calculate expiry of 1 timers
2013-04-11 14:12:00.608+0000: 1573: debug : virEventPollCalculateTimeout:351 : Timeout at 0 due in -1 ms
2013-04-11 14:12:00.608+0000: 1573: debug : virEventPollRunOnce:619 : EVENT_POLL_RUN: nhandles=3 timeout=-1
2013-04-11 14:12:00.921+0000: 1572: debug : virNetMessageDecodeLength:149 : Got length, now need 28 total (24 more)
2013-04-11 14:12:00.921+0000: 1572: debug : virNetClientCallDispatch:934 : RPC_CLIENT_MSG_RX: client=0x7fe24329a010 len=28 prog=536903814 vers=1 proc=1 type=1 status=0 serial=2
2013-04-11 14:12:00.921+0000: 1572: debug : virKeepAliveCheckMessage:424 : ka=0x7fe23801a040, client=0x7fe24329a010, msg=0x7fe24329a068
2013-04-11 14:12:00.921+0000: 1572: debug : virNetClientIOEventLoopPassTheBuck:1254 : Giving up the buck 0x7fe238017ed0
2013-04-11 14:12:00.921+0000: 1572: debug : virNetClientIOEventLoopPassTheBuck:1268 : No thread to pass the buck to
2013-04-11 14:12:00.921+0000: 1572: debug : virEventPollUpdateHandle:151 : EVENT_POLL_UPDATE_HANDLE: watch=4 events=1
2013-04-11 14:12:00.921+0000: 1572: debug : virEventPollInterruptLocked:706 : Interrupting
2013-04-11 14:12:00.921+0000: 1572: debug : virNetClientIO:1628 : All done with our call (nil) 0x7fe238017ed0 2
2013-04-11 14:12:00.921+0000: 1572: debug : virNetMessageFree:75 : msg=0x7fe238025ab0 nfds=0 cb=(nil)
2013-04-11 14:12:00.921+0000: 1573: debug : virEventPollRunOnce:630 : Poll got 1 event(s)
2013-04-11 14:12:00.921+0000: 1573: debug : virEventPollDispatchTimeouts:415 : Dispatch 1
2013-04-11 14:12:00.921+0000: 1573: debug : virEventPollDispatchHandles:460 : Dispatch 3
2013-04-11 14:12:00.921+0000: 1573: debug : virEventPollDispatchHandles:474 : i=0 w=1
2013-04-11 14:12:00.921+0000: 1573: debug : virEventPollDispatchHandles:488 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1
2013-04-11 14:12:00.921+0000: 1573: debug : virEventPollDispatchHandles:474 : i=1 w=2
2013-04-11 14:12:00.921+0000: 1573: debug : virEventPollDispatchHandles:474 : i=2 w=3
2013-04-11 14:12:00.921+0000: 1573: debug : virEventPollCleanupTimeouts:506 : Cleanup 1
2013-04-11 14:12:00.921+0000: 1573: debug : virEventPollCleanupHandles:554 : Cleanup 4
2013-04-11 14:12:00.921+0000: 1573: debug : virEventRunDefaultImpl:244 : running default event implementation
2013-04-11 14:12:00.921+0000: 1573: debug : virEventPollCleanupTimeouts:506 : Cleanup 1
2013-04-11 14:12:00.921+0000: 1573: debug : virEventPollCleanupHandles:554 : Cleanup 4
2013-04-11 14:12:00.921+0000: 1573: debug : virEventPollMakePollFDs:383 : Prepare n=0 w=1, f=4 e=1 d=0
2013-04-11 14:12:00.921+0000: 1573: debug : virEventPollMakePollFDs:383 : Prepare n=1 w=2, f=8 e=1 d=0
2013-04-11 14:12:00.921+0000: 1573: debug : virEventPollMakePollFDs:383 : Prepare n=2 w=3, f=10 e=1 d=0
2013-04-11 14:12:00.921+0000: 1573: debug : virEventPollMakePollFDs:383 : Prepare n=3 w=4, f=11 e=1 d=0
2013-04-11 14:12:00.921+0000: 1573: debug : virEventPollCalculateTimeout:325 : Calculate expiry of 1 timers
2013-04-11 14:12:00.921+0000: 1573: debug : virEventPollCalculateTimeout:351 : Timeout at 0 due in -1 ms
2013-04-11 14:12:00.921+0000: 1573: debug : virEventPollRunOnce:619 : EVENT_POLL_RUN: nhandles=4 timeout=-1
2013-04-11 14:12:00.921+0000: 1572: debug : do_open:1254 : network driver 2 remote returned SUCCESS
2013-04-11 14:12:00.921+0000: 1572: debug : do_open:1269 : interface driver 0 Test returned DECLINED
2013-04-11 14:12:00.921+0000: 1572: debug : do_open:1269 : interface driver 1 remote returned SUCCESS
2013-04-11 14:12:00.921+0000: 1572: debug : do_open:1285 : storage driver 0 Test returned DECLINED
2013-04-11 14:12:00.921+0000: 1572: debug : do_open:1285 : storage driver 1 VBOX returned DECLINED
2013-04-11 14:12:00.921+0000: 1572: debug : do_open:1285 : storage driver 2 remote returned SUCCESS
2013-04-11 14:12:00.921+0000: 1572: debug : do_open:1301 : node driver 0 Test returned DECLINED
2013-04-11 14:12:00.921+0000: 1572: debug : do_open:1301 : node driver 1 remote returned SUCCESS
2013-04-11 14:12:00.921+0000: 1572: debug : do_open:1317 : secret driver 0 Test returned DECLINED
2013-04-11 14:12:00.921+0000: 1572: debug : do_open:1317 : secret driver 1 remote returned SUCCESS
2013-04-11 14:12:00.921+0000: 1572: debug : do_open:1333 : nwfilter driver 0 Test returned DECLINED
2013-04-11 14:12:00.921+0000: 1572: debug : do_open:1333 : nwfilter driver 1 remote returned SUCCESS
2013-04-11 14:12:00.921+0000: 1572: debug : virDomainDefineXML:7907 : conn=0xafe720, xml=<domain type='xen'>
  <name>ucs31-64-steuwer</name>
  <uuid>284afb36-8940-5a5f-f5f3-d4df7e6b8255</uuid>
  <memory unit='KiB'>524288</memory>
  <currentMemory unit='KiB'>524288</currentMemory>
  <vcpu placement='static'>1</vcpu>
  <bootloader>/usr/bin/pygrub</bootloader>
  <bootloader_args>-q</bootloader_args>
  <os>
    <type>linux</type>
  </os>
  <clock offset='utc' adjustment='reset'/>
  <on_poweroff>destroy</on_poweroff>
  <on_reboot>restart</on_reboot>
  <on_crash>destroy</on_crash>
  <devices>
    <emulator>/usr/lib/xen/bin/qemu-dm</emulator>
    <disk type='file' device='disk'>
      <driver name='tap2' type='aio'/>
      <source file='/var/lib/libvirt/images/ucs31-64-steuwer-0.img'/>
      <target dev='xvda' bus='xen'/>
    </disk>
    <interface type='bridge'>
      <mac address='00:16:3e:06:6a:b6'/>
      <source bridge='eth0'/>
      <script path='vif-bridge'/>
      <model type='netfront'/>
    </interface>
    <console type='pty'>
      <target type='xen' port='0'/>
    </console>
    <input type='mouse' bus='xen'/>
    <graphics type='vnc' port='-1' autoport='yes' listen='0.0.0.0' keymap='en-us'>
      <listen type='address' address='0.0.0.0'/>
    </graphics>
  </devices>
</domain>


2013-04-11 14:12:00.922+0000: 1572: debug : xenFormatSxpr:2235 : Formatting domain sexpr
2013-04-11 14:12:00.922+0000: 1572: debug : xenFormatSxpr:2597 : Formatted sexpr: 
(vm (name 'ucs31-64-steuwer')(memory 512)(maxmem 512)(vcpus 1)(uuid '284afb36-8940-5a5f-f5f3-d4df7e6b8255')(bootloader '/usr/bin/pygrub')(bootloader_args '-q')(on_poweroff 'destroy')(on_reboot 'restart')(on_crash 'destroy')(image (linux (localtime 0)))(localtime 0)(device (tap2 (dev 'xvda')(uname 'tap2:aio:/var/lib/libvirt/images/ucs31-64-steuwer-0.img')(mode 'w')))(device (vif (mac '00:16:3e:06:6a:b6')(bridge 'eth0')(script 'vif-bridge')(model 'netfront')))(device (vkbd))(device (vfb (type vnc)(vncunused 1)(vnclisten '0.0.0.0')(keymap 'en-us'))))
2013-04-11 14:12:00.922+0000: 1572: debug : xend_op_ext:506 : xend op: op=new&config=%28vm%20%28name%20%27ucs31%2d64%2dsteuwer%27%29%28memory%20512%29%28maxmem%20512%29%28vcpus%201%29%28uuid%20%27284afb36%2d8940%2d5a5f%2df5f3%2dd4df7e6b8255%27%29%28bootloader%20%27%2fusr%2fbin%2fpygrub%27%29%28bootloader%5fargs%20%27%2dq%27%29%28on%5fpoweroff%20%27destroy%27%29%28on%5freboot%20%27restart%27%29%28on%5fcrash%20%27destroy%27%29%28image%20%28linux%20%28localtime%200%29%29%29%28localtime%200%29%28device%20%28tap2%20%28dev%20%27xvda%27%29%28uname%20%27tap2%3aaio%3a%2fvar%2flib%2flibvirt%2fimages%2fucs31%2d64%2dsteuwer%2d0%2eimg%27%29%28mode%20%27w%27%29%29%29%28device%20%28vif%20%28mac%20%2700%3a16%3a3e%3a06%3a6a%3ab6%27%29%28bridge%20%27eth0%27%29%28script%20%27vif%2dbridge%27%29%28model%20%27netfront%27%29%29%29%28device%20%28vkbd%29%29%28device%20%28vfb%20%28type%20vnc%29%28vncunused%201%29%28vnclisten%20%270%2e0%2e0%2e0%27%29%28keymap%20%27en%2dus%27%29%29%29%29

2013-04-11 14:12:00.933+0000: 1573: debug : virEventPollRunOnce:630 : Poll got 1 event(s)
2013-04-11 14:12:00.933+0000: 1573: debug : virEventPollDispatchTimeouts:415 : Dispatch 1
2013-04-11 14:12:00.933+0000: 1573: debug : virEventPollDispatchHandles:460 : Dispatch 4
2013-04-11 14:12:00.933+0000: 1573: debug : virEventPollDispatchHandles:474 : i=0 w=1
2013-04-11 14:12:00.934+0000: 1573: debug : virEventPollDispatchHandles:474 : i=1 w=2
2013-04-11 14:12:00.934+0000: 1573: debug : virEventPollDispatchHandles:474 : i=2 w=3
2013-04-11 14:12:00.934+0000: 1573: debug : virEventPollDispatchHandles:488 : EVENT_POLL_DISPATCH_HANDLE: watch=3 events=1
2013-04-11 14:12:00.934+0000: 1573: debug : xenInotifyEvent:255 : got inotify event
2013-04-11 14:12:00.934+0000: 1573: debug : xenInotifyXendDomainsDirLookup:101 : Looking for dom with uuid: 284afb36-8940-5a5f-f5f3-d4df7e6b8255
2013-04-11 14:12:00.943+0000: 1572: debug : virDomainLookupByName:2178 : conn=0xafe720, name=ucs31-64-steuwer
2013-04-11 14:12:00.954+0000: 1573: debug : virDomainFree:2345 : dom=0xafea20, (VM: name=ucs31-64-steuwer, uuid=284afb36-8940-5a5f-f5f3-d4df7e6b8255)
2013-04-11 14:12:00.954+0000: 1573: debug : virUnrefDomain:276 : unref domain 0xafea20 ucs31-64-steuwer 1
2013-04-11 14:12:00.954+0000: 1573: debug : virReleaseDomain:238 : release domain 0xafea20 ucs31-64-steuwer 284afb36-8940-5a5f-f5f3-d4df7e6b8255
2013-04-11 14:12:00.954+0000: 1573: debug : virReleaseDomain:246 : unref connection 0xafe720 2
2013-04-11 14:12:00.955+0000: 1573: debug : xenInotifyXendDomainsDirLookup:101 : Looking for dom with uuid: 284afb36-8940-5a5f-f5f3-d4df7e6b8255
2013-04-11 14:12:00.959+0000: 1572: debug : virDomainGetName:3465 : domain=0x7fe238025820
Domain ucs31-64-steuwer defined from ucs31-64-steuwer.xml
2013-04-11 14:12:00.959+0000: 1572: debug : virDomainFree:2345 : dom=0x7fe238025820, (VM: name=ucs31-64-steuwer, uuid=284afb36-8940-5a5f-f5f3-d4df7e6b8255)
2013-04-11 14:12:00.959+0000: 1572: debug : virUnrefDomain:276 : unref domain 0x7fe238025820 ucs31-64-steuwer 1
2013-04-11 14:12:00.959+0000: 1572: debug : virReleaseDomain:238 : release domain 0x7fe238025820 ucs31-64-steuwer 284afb36-8940-5a5f-f5f3-d4df7e6b8255
2013-04-11 14:12:00.959+0000: 1572: debug : virReleaseDomain:246 : unref connection 0xafe720 2

2013-04-11 14:12:00.959+0000: 1572: debug : virConnectClose:1496 : conn=0xafe720
2013-04-11 14:12:00.959+0000: 1572: debug : virUnrefConnect:145 : unref connection 0xafe720 1
2013-04-11 14:12:00.959+0000: 1572: debug : virReleaseConnect:94 : release connection 0xafe720
2013-04-11 14:12:00.959+0000: 1572: debug : virNetMessageNew:48 : msg=0x7fe238025ab0 tracked=0
2013-04-11 14:12:00.959+0000: 1572: debug : virNetMessageEncodePayload:351 : Encode length as 28
2013-04-11 14:12:00.959+0000: 1572: debug : virNetClientSendInternal:1683 : RPC_CLIENT_MSG_TX_QUEUE: client=0x7fe24329a010 len=28 prog=536903814 vers=1 proc=2 type=0 status=0 serial=3
2013-04-11 14:12:00.959+0000: 1572: debug : virNetClientIO:1541 : Outgoing message prog=536903814 version=1 serial=3 proc=2 type=0 length=28 dispatch=(nil)
2013-04-11 14:12:00.959+0000: 1572: debug : virNetClientIO:1599 : We have the buck 0x7fe238017ed0 0x7fe238017ed0
2013-04-11 14:12:00.959+0000: 1572: debug : virEventPollUpdateHandle:151 : EVENT_POLL_UPDATE_HANDLE: watch=4 events=0
2013-04-11 14:12:00.959+0000: 1572: debug : virEventPollInterruptLocked:706 : Interrupting
2013-04-11 14:12:00.967+0000: 1573: debug : virDomainFree:2345 : dom=0x7fe238016da0, (VM: name=ucs31-64-steuwer, uuid=284afb36-8940-5a5f-f5f3-d4df7e6b8255)
2013-04-11 14:12:00.967+0000: 1573: debug : virUnrefDomain:276 : unref domain 0x7fe238016da0 ucs31-64-steuwer 1
2013-04-11 14:12:00.968+0000: 1573: debug : virReleaseDomain:238 : release domain 0x7fe238016da0 ucs31-64-steuwer 284afb36-8940-5a5f-f5f3-d4df7e6b8255
2013-04-11 14:12:00.968+0000: 1573: debug : virReleaseDomain:246 : unref connection 0xafe720 1
2013-04-11 14:12:00.968+0000: 1573: debug : virReleaseConnect:94 : release connection 0xafe720
2013-04-11 14:12:00.968+0000: 1573: debug : virNetMessageNew:48 : msg=0x7fe238065b20 tracked=0
2013-04-11 14:12:00.968+0000: 1573: debug : virNetMessageEncodePayload:351 : Encode length as 28
2013-04-11 14:12:00.968+0000: 1573: debug : virNetClientSendInternal:1683 : RPC_CLIENT_MSG_TX_QUEUE: client=0x7fe24329a010 len=28 prog=536903814 vers=1 proc=2 type=0 status=0 serial=4
2013-04-11 14:12:00.968+0000: 1573: debug : virNetClientIO:1541 : Outgoing message prog=536903814 version=1 serial=4 proc=2 type=0 length=28 dispatch=0x7fe238017ed0
2013-04-11 14:12:00.968+0000: 1573: debug : virNetClientIO:1558 : Going to sleep 0x7fe238017ed0 0x7fe2380196a0
2013-04-11 14:12:00.968+0000: 1572: debug : virNetClientIOEventLoop:1377 : Woken up from poll by other thread
2013-04-11 14:12:00.981+0000: 1572: debug : virNetMessageDecodeLength:149 : Got length, now need 28 total (24 more)
2013-04-11 14:12:00.981+0000: 1572: debug : virNetClientCallDispatch:934 : RPC_CLIENT_MSG_RX: client=0x7fe24329a010 len=28 prog=536903814 vers=1 proc=2 type=1 status=0 serial=3
2013-04-11 14:12:00.981+0000: 1572: debug : virKeepAliveCheckMessage:424 : ka=0x7fe23801a040, client=0x7fe24329a010, msg=0x7fe24329a068
2013-04-11 14:12:00.981+0000: 1572: debug : virNetClientIOEventLoopPassTheBuck:1254 : Giving up the buck 0x7fe238017ed0
2013-04-11 14:12:00.981+0000: 1572: debug : virNetClientIOEventLoopPassTheBuck:1260 : Passing the buck to 0x7fe2380196a0
2013-04-11 14:12:00.981+0000: 1572: debug : virEventPollUpdateHandle:151 : EVENT_POLL_UPDATE_HANDLE: watch=4 events=1
2013-04-11 14:12:00.981+0000: 1572: debug : virEventPollInterruptLocked:706 : Interrupting
2013-04-11 14:12:00.981+0000: 1572: debug : virNetClientIO:1628 : All done with our call 0x7fe2380196a0 0x7fe238017ed0 2
2013-04-11 14:12:00.981+0000: 1572: debug : virNetMessageFree:75 : msg=0x7fe238025ab0 nfds=0 cb=(nil)
2013-04-11 14:12:00.981+0000: 1573: debug : virNetClientIO:1567 : Wokeup from sleep 0x7fe2380196a0 0x7fe2380196a0
2013-04-11 14:12:00.981+0000: 1573: debug : virNetClientIO:1599 : We have the buck 0x7fe2380196a0 0x7fe2380196a0
2013-04-11 14:12:00.981+0000: 1573: debug : virEventPollUpdateHandle:151 : EVENT_POLL_UPDATE_HANDLE: watch=4 events=0
2013-04-11 14:12:00.981+0000: 1572: debug : virNetClientClose:521 : client=0x7fe24329a010
2013-04-11 14:12:00.981+0000: 1573: debug : virEventPollInterruptLocked:702 : Skip interrupt, 1 1053804288
2013-04-11 14:12:00.981+0000: 1573: debug : virNetClientIOEventLoopPassTheBuck:1254 : Giving up the buck 0x7fe2380196a0
2013-04-11 14:12:00.981+0000: 1573: debug : virNetClientIOEventLoopPassTheBuck:1268 : No thread to pass the buck to
2013-04-11 14:12:00.981+0000: 1573: debug : virEventPollUpdateHandle:151 : EVENT_POLL_UPDATE_HANDLE: watch=4 events=1
2013-04-11 14:12:00.981+0000: 1573: debug : virEventPollInterruptLocked:702 : Skip interrupt, 1 1053804288
2013-04-11 14:12:00.981+0000: 1573: debug : virNetClientIO:1628 : All done with our call (nil) 0x7fe2380196a0 -1
2013-04-11 14:12:00.981+0000: 1573: debug : virNetMessageFree:75 : msg=0x7fe238065b20 nfds=0 cb=(nil)
2013-04-11 14:12:00.981+0000: 1572: debug : virNetClientCloseLocked:489 : client=0x7fe24329a010, sock=0x7fe23801c270
2013-04-11 14:12:00.982+0000: 1572: debug : virEventPollRemoveHandle:180 : EVENT_POLL_REMOVE_HANDLE: watch=4
2013-04-11 14:12:00.982+0000: 1572: debug : virEventPollRemoveHandle:193 : mark delete 3 11
2013-04-11 14:12:00.982+0000: 1572: debug : virEventPollInterruptLocked:706 : Interrupting
2013-04-11 14:12:00.982+0000: 1572: debug : virNetSocketFree:722 : RPC_SOCKET_FREE: sock=0x7fe23801c270 refs=2
2013-04-11 14:12:00.982+0000: 1572: debug : virKeepAliveStopInternal:382 : RPC_KEEPALIVE_STOP: ka=0x7fe23801a040 client=0x7fe24329a010 all=1
2013-04-11 14:12:00.982+0000: 1572: debug : virEventPollRemoveTimeout:293 : EVENT_POLL_REMOVE_TIMEOUT: timer=1
2013-04-11 14:12:00.982+0000: 1572: debug : virEventPollInterruptLocked:706 : Interrupting
2013-04-11 14:12:00.982+0000: 1572: debug : virKeepAliveFree:304 : RPC_KEEPALIVE_FREE: ka=0x7fe23801a040 client=0x7fe24329a010 refs=2
2013-04-11 14:12:00.982+0000: 1572: debug : virNetClientFree:454 : RPC_CLIENT_FREE: client=0x7fe24329a010 refs=3
2013-04-11 14:12:00.982+0000: 1572: debug : virEventPollRemoveHandle:180 : EVENT_POLL_REMOVE_HANDLE: watch=2
2013-04-11 14:12:00.982+0000: 1572: debug : virEventPollRemoveHandle:193 : mark delete 1 8
2013-04-11 14:12:00.982+0000: 1572: debug : virEventPollInterruptLocked:706 : Interrupting
2013-04-11 14:12:00.982+0000: 1572: debug : virEventPollRemoveHandle:180 : EVENT_POLL_REMOVE_HANDLE: watch=3
2013-04-11 14:12:00.982+0000: 1572: debug : virEventPollRemoveHandle:193 : mark delete 2 10
2013-04-11 14:12:00.982+0000: 1572: debug : virEventPollInterruptLocked:706 : Interrupting
2013-04-11 14:12:01.085+0000: 1572: debug : virEventPollInterruptLocked:706 : Interrupting
2013-04-11 14:12:01.085+0000: 1572: debug : virEventPollAddTimeout:248 : EVENT_POLL_ADD_TIMEOUT: timer=2 frequency=0 cb=0x40bd40 opaque=(nil) ff=(nil)
^C
root@xen10:~# virsh undefine ucs31-64-steuwer
Domain ucs31-64-steuwer has been undefined

root@xen10:~# LIBVIRT_DEBUG=1 virsh define ucs31-64-steuwer.xml 
2013-04-11 14:13:13.722+0000: 1856: info : libvirt version: 0.9.12
2013-04-11 14:13:13.722+0000: 1856: debug : virInitialize:414 : register drivers
2013-04-11 14:13:13.723+0000: 1856: debug : virRegisterDriver:775 : driver=0x7f09e9d04460 name=Test
2013-04-11 14:13:13.723+0000: 1856: debug : virRegisterDriver:799 : registering Test as driver 0
2013-04-11 14:13:13.723+0000: 1856: debug : virRegisterNetworkDriver:592 : registering Test as network driver 0
2013-04-11 14:13:13.723+0000: 1856: debug : virRegisterInterfaceDriver:625 : registering Test as interface driver 0
2013-04-11 14:13:13.723+0000: 1856: debug : virRegisterStorageDriver:658 : registering Test as storage driver 0
2013-04-11 14:13:13.723+0000: 1856: debug : virRegisterDeviceMonitor:691 : registering Test as device driver 0
2013-04-11 14:13:13.724+0000: 1856: debug : virRegisterSecretDriver:724 : registering Test as secret driver 0
2013-04-11 14:13:13.724+0000: 1856: debug : virRegisterNWFilterDriver:757 : registering Test as network filter driver 0
2013-04-11 14:13:13.724+0000: 1856: debug : xenHypervisorInit:2105 : Using new hypervisor call: 40001
2013-04-11 14:13:13.725+0000: 1856: debug : xenHypervisorInit:2214 : Using hypervisor call v2, sys ver8 dom ver7
2013-04-11 14:13:13.725+0000: 1856: debug : virRegisterDriver:775 : driver=0x7f09e9d059a0 name=Xen
2013-04-11 14:13:13.725+0000: 1856: debug : virRegisterDriver:799 : registering Xen as driver 1
2013-04-11 14:13:13.725+0000: 1856: debug : virRegisterDriver:775 : driver=0x7f09e9d06240 name=OPENVZ
2013-04-11 14:13:13.725+0000: 1856: debug : virRegisterDriver:799 : registering OPENVZ as driver 2
2013-04-11 14:13:13.725+0000: 1856: debug : virRegisterDriver:775 : driver=0x7f09e9d06760 name=VMWARE
2013-04-11 14:13:13.725+0000: 1856: debug : virRegisterDriver:799 : registering VMWARE as driver 3
2013-04-11 14:13:13.726+0000: 1856: debug : vboxRegister:137 : VBoxCGlueInit failed, using dummy driver
2013-04-11 14:13:13.726+0000: 1856: debug : virRegisterDriver:775 : driver=0x7f09e9d06c80 name=VBOX
2013-04-11 14:13:13.726+0000: 1856: debug : virRegisterDriver:799 : registering VBOX as driver 4
2013-04-11 14:13:13.726+0000: 1856: debug : virRegisterNetworkDriver:592 : registering VBOX as network driver 1
2013-04-11 14:13:13.726+0000: 1856: debug : virRegisterStorageDriver:658 : registering VBOX as storage driver 1
2013-04-11 14:13:13.726+0000: 1856: debug : virRegisterDriver:775 : driver=0x7f09e9d04d40 name=remote
2013-04-11 14:13:13.726+0000: 1856: debug : virRegisterDriver:799 : registering remote as driver 5
2013-04-11 14:13:13.726+0000: 1856: debug : virRegisterNetworkDriver:592 : registering remote as network driver 2
2013-04-11 14:13:13.726+0000: 1856: debug : virRegisterInterfaceDriver:625 : registering remote as interface driver 1
2013-04-11 14:13:13.726+0000: 1856: debug : virRegisterStorageDriver:658 : registering remote as storage driver 2
2013-04-11 14:13:13.727+0000: 1856: debug : virRegisterDeviceMonitor:691 : registering remote as device driver 1
2013-04-11 14:13:13.727+0000: 1856: debug : virRegisterSecretDriver:724 : registering remote as secret driver 1
2013-04-11 14:13:13.727+0000: 1856: debug : virRegisterNWFilterDriver:757 : registering remote as network filter driver 1
2013-04-11 14:13:13.727+0000: 1856: debug : virEventRegisterDefaultImpl:204 : registering default event implementation
2013-04-11 14:13:13.727+0000: 1856: debug : virEventPollAddHandle:116 : Used 0 handle slots, adding at least 10 more
2013-04-11 14:13:13.727+0000: 1856: debug : virEventPollInterruptLocked:702 : Skip interrupt, 0 0
2013-04-11 14:13:13.727+0000: 1856: debug : virEventPollAddHandle:141 : EVENT_POLL_ADD_HANDLE: watch=1 fd=4 events=1 cb=0x7f09e98bc0f0 opaque=(nil) ff=(nil)
2013-04-11 14:13:13.728+0000: 1856: debug : virEventRegisterImpl:177 : addHandle=0x7f09e98bd030 updateHandle=0x7f09e98bbfc0 removeHandle=0x7f09e98bbe60 addTimeout=0x7f09e98bce50 updateTimeout=0x7f09e98bc150 removeTimeout=0x7f09e98bbd40
2013-04-11 14:13:13.728+0000: 1856: debug : virConnectOpenAuth:1455 : name=(null), auth=0x7f09e9d043e0, flags=0
2013-04-11 14:13:13.728+0000: 1856: debug : virConnectGetConfigFile:1008 : Loading config file '/etc/libvirt/libvirt.conf'
2013-04-11 14:13:13.728+0000: 1857: debug : virEventRunDefaultImpl:244 : running default event implementation
2013-04-11 14:13:13.728+0000: 1857: debug : virEventPollCleanupTimeouts:506 : Cleanup 0
2013-04-11 14:13:13.728+0000: 1857: debug : virEventPollCleanupTimeouts:542 : Found 0 out of 0 timeout slots used, releasing 0
2013-04-11 14:13:13.728+0000: 1857: debug : virEventPollCleanupHandles:554 : Cleanup 1
2013-04-11 14:13:13.728+0000: 1857: debug : virEventPollMakePollFDs:383 : Prepare n=0 w=1, f=4 e=1 d=0
2013-04-11 14:13:13.728+0000: 1857: debug : virEventPollCalculateTimeout:325 : Calculate expiry of 0 timers
2013-04-11 14:13:13.728+0000: 1857: debug : virEventPollCalculateTimeout:351 : Timeout at 0 due in -1 ms
2013-04-11 14:13:13.728+0000: 1857: debug : virEventPollRunOnce:619 : EVENT_POLL_RUN: nhandles=1 timeout=-1
2013-04-11 14:13:13.728+0000: 1856: debug : do_open:1186 : no name, allowing driver auto-select
2013-04-11 14:13:13.728+0000: 1856: debug : do_open:1226 : trying driver 0 (Test) ...
2013-04-11 14:13:13.728+0000: 1856: debug : do_open:1232 : driver 0 Test returned DECLINED
2013-04-11 14:13:13.729+0000: 1856: debug : do_open:1226 : trying driver 1 (Xen) ...
2013-04-11 14:13:13.729+0000: 1856: debug : virCommandRunAsync:2174 : About to run /usr/sbin/xend status
2013-04-11 14:13:13.730+0000: 1856: debug : virCommandRunAsync:2192 : Command result 0, with PID 1858
2013-04-11 14:13:13.966+0000: 1856: debug : virCommandRun:1994 : Result exit status 0, stdout: '' stderr: '2013-04-11 14:13:13.731+0000: 1858: debug : virCommandHook:2093 : Hook is done 0
'
2013-04-11 14:13:13.966+0000: 1856: debug : xenUnifiedOpen:339 : Trying hypervisor sub-driver
2013-04-11 14:13:13.966+0000: 1856: debug : xenUnifiedOpen:341 : Activated hypervisor sub-driver
2013-04-11 14:13:13.966+0000: 1856: debug : xenUnifiedOpen:347 : Trying XenD sub-driver
2013-04-11 14:13:13.968+0000: 1856: debug : xenUnifiedOpen:349 : Activated XenD sub-driver
2013-04-11 14:13:13.968+0000: 1856: debug : xenUnifiedOpen:361 : Trying XS sub-driver
2013-04-11 14:13:13.968+0000: 1856: debug : virEventPollInterruptLocked:706 : Interrupting
2013-04-11 14:13:13.968+0000: 1856: debug : virEventPollAddHandle:141 : EVENT_POLL_ADD_HANDLE: watch=2 fd=8 events=1 cb=0x7f09e99dac80 opaque=0xbf8720 ff=(nil)
2013-04-11 14:13:13.968+0000: 1856: debug : xenUnifiedOpen:363 : Activated XS sub-driver
2013-04-11 14:13:13.968+0000: 1857: debug : virEventPollRunOnce:630 : Poll got 1 event(s)
2013-04-11 14:13:13.968+0000: 1857: debug : virEventPollDispatchTimeouts:415 : Dispatch 0
2013-04-11 14:13:13.968+0000: 1857: debug : virEventPollDispatchHandles:460 : Dispatch 1
2013-04-11 14:13:13.968+0000: 1857: debug : virEventPollDispatchHandles:474 : i=0 w=1
2013-04-11 14:13:13.968+0000: 1857: debug : virEventPollDispatchHandles:488 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1
2013-04-11 14:13:13.968+0000: 1857: debug : virEventPollCleanupTimeouts:506 : Cleanup 0
2013-04-11 14:13:13.968+0000: 1857: debug : virEventPollCleanupTimeouts:542 : Found 0 out of 0 timeout slots used, releasing 0
2013-04-11 14:13:13.968+0000: 1857: debug : virEventPollCleanupHandles:554 : Cleanup 2
2013-04-11 14:13:13.968+0000: 1857: debug : virEventRunDefaultImpl:244 : running default event implementation
2013-04-11 14:13:13.968+0000: 1857: debug : virEventPollCleanupTimeouts:506 : Cleanup 0
2013-04-11 14:13:13.968+0000: 1857: debug : virEventPollCleanupTimeouts:542 : Found 0 out of 0 timeout slots used, releasing 0
2013-04-11 14:13:13.968+0000: 1857: debug : virEventPollCleanupHandles:554 : Cleanup 2
2013-04-11 14:13:13.968+0000: 1857: debug : virEventPollMakePollFDs:383 : Prepare n=0 w=1, f=4 e=1 d=0
2013-04-11 14:13:13.968+0000: 1857: debug : virEventPollMakePollFDs:383 : Prepare n=1 w=2, f=8 e=1 d=0
2013-04-11 14:13:13.968+0000: 1857: debug : virEventPollCalculateTimeout:325 : Calculate expiry of 0 timers
2013-04-11 14:13:13.968+0000: 1857: debug : virEventPollCalculateTimeout:351 : Timeout at 0 due in -1 ms
2013-04-11 14:13:13.968+0000: 1857: debug : virEventPollRunOnce:619 : EVENT_POLL_RUN: nhandles=2 timeout=-1
2013-04-11 14:13:13.968+0000: 1857: debug : virEventPollRunOnce:630 : Poll got 1 event(s)
2013-04-11 14:13:13.968+0000: 1857: debug : virEventPollDispatchTimeouts:415 : Dispatch 0
2013-04-11 14:13:13.968+0000: 1857: debug : virEventPollDispatchHandles:460 : Dispatch 2
2013-04-11 14:13:13.968+0000: 1857: debug : virEventPollDispatchHandles:474 : i=0 w=1
2013-04-11 14:13:13.968+0000: 1857: debug : virEventPollDispatchHandles:474 : i=1 w=2
2013-04-11 14:13:13.968+0000: 1857: debug : virEventPollDispatchHandles:488 : EVENT_POLL_DISPATCH_HANDLE: watch=2 events=1
2013-04-11 14:13:13.968+0000: 1857: debug : virEventPollCleanupTimeouts:506 : Cleanup 0
2013-04-11 14:13:13.968+0000: 1857: debug : virEventPollCleanupTimeouts:542 : Found 0 out of 0 timeout slots used, releasing 0
2013-04-11 14:13:13.969+0000: 1857: debug : virEventPollCleanupHandles:554 : Cleanup 2
2013-04-11 14:13:13.969+0000: 1857: debug : virEventRunDefaultImpl:244 : running default event implementation
2013-04-11 14:13:13.969+0000: 1857: debug : virEventPollCleanupTimeouts:506 : Cleanup 0
2013-04-11 14:13:13.969+0000: 1857: debug : virEventPollCleanupTimeouts:542 : Found 0 out of 0 timeout slots used, releasing 0
2013-04-11 14:13:13.969+0000: 1857: debug : virEventPollCleanupHandles:554 : Cleanup 2
2013-04-11 14:13:13.969+0000: 1857: debug : virEventPollMakePollFDs:383 : Prepare n=0 w=1, f=4 e=1 d=0
2013-04-11 14:13:13.969+0000: 1857: debug : virEventPollMakePollFDs:383 : Prepare n=1 w=2, f=8 e=1 d=0
2013-04-11 14:13:13.969+0000: 1857: debug : virEventPollCalculateTimeout:325 : Calculate expiry of 0 timers
2013-04-11 14:13:13.969+0000: 1857: debug : virEventPollCalculateTimeout:351 : Timeout at 0 due in -1 ms
2013-04-11 14:13:13.969+0000: 1857: debug : virEventPollRunOnce:619 : EVENT_POLL_RUN: nhandles=2 timeout=-1
2013-04-11 14:13:13.969+0000: 1857: debug : virEventPollRunOnce:630 : Poll got 1 event(s)
2013-04-11 14:13:13.969+0000: 1857: debug : virEventPollDispatchTimeouts:415 : Dispatch 0
2013-04-11 14:13:13.969+0000: 1857: debug : virEventPollDispatchHandles:460 : Dispatch 2
2013-04-11 14:13:13.969+0000: 1857: debug : virEventPollDispatchHandles:474 : i=0 w=1
2013-04-11 14:13:13.969+0000: 1857: debug : virEventPollDispatchHandles:474 : i=1 w=2
2013-04-11 14:13:13.969+0000: 1857: debug : virEventPollDispatchHandles:488 : EVENT_POLL_DISPATCH_HANDLE: watch=2 events=1
2013-04-11 14:13:13.970+0000: 1857: debug : xenStoreDomainIntroduced:1382 : Some domains were missing, trying again
2013-04-11 14:13:13.973+0000: 1856: debug : virCommandRunAsync:2174 : About to run pm-is-supported --suspend
2013-04-11 14:13:13.974+0000: 1856: debug : virCommandRunAsync:2192 : Command result 0, with PID 1878
2013-04-11 14:13:13.985+0000: 1856: debug : virCommandRun:1994 : Result exit status 1, stdout: '' stderr: '2013-04-11 14:13:13.975+0000: 1878: debug : virCommandHook:2093 : Hook is done 0
'
2013-04-11 14:13:13.985+0000: 1856: debug : virCommandRunAsync:2174 : About to run pm-is-supported --hibernate
2013-04-11 14:13:13.986+0000: 1856: debug : virCommandRunAsync:2192 : Command result 0, with PID 1884
2013-04-11 14:13:13.997+0000: 1856: debug : virCommandRun:1994 : Result exit status 0, stdout: '' stderr: '2013-04-11 14:13:13.987+0000: 1884: debug : virCommandHook:2093 : Hook is done 0
'
2013-04-11 14:13:13.997+0000: 1856: debug : virCommandRunAsync:2174 : About to run pm-is-supported --suspend-hybrid
2013-04-11 14:13:13.998+0000: 1856: debug : virCommandRunAsync:2192 : Command result 0, with PID 1890
2013-04-11 14:13:14.009+0000: 1856: debug : virCommandRun:1994 : Result exit status 1, stdout: '' stderr: '2013-04-11 14:13:13.999+0000: 1890: debug : virCommandHook:2093 : Hook is done 0
'
2013-04-11 14:13:14.009+0000: 1856: debug : xenUnifiedOpen:388 : Trying Xen inotify sub-driver
2013-04-11 14:13:14.009+0000: 1856: debug : xenInotifyXendDomainsDirLookup:101 : Looking for dom with uuid: 410d7908-a68d-d900-77da-f15e3e6e3ccc
2013-04-11 14:13:14.031+0000: 1856: debug : virDomainFree:2345 : dom=0xc1d210, (VM: name=ucs31-64-1, uuid=410d7908-a68d-d900-77da-f15e3e6e3ccc)
2013-04-11 14:13:14.031+0000: 1856: debug : virUnrefDomain:276 : unref domain 0xc1d210 ucs31-64-1 1
2013-04-11 14:13:14.031+0000: 1856: debug : virReleaseDomain:238 : release domain 0xc1d210 ucs31-64-1 410d7908-a68d-d900-77da-f15e3e6e3ccc
2013-04-11 14:13:14.031+0000: 1856: debug : virReleaseDomain:246 : unref connection 0xbf8720 2
2013-04-11 14:13:14.031+0000: 1856: debug : xenInotifyXendDomainsDirLookup:101 : Looking for dom with uuid: 536eb575-eaa8-04fb-38f8-f04963792640
2013-04-11 14:13:14.036+0000: 1856: debug : virDomainFree:2345 : dom=0xc1b450, (VM: name=bs42z98v-01, uuid=536eb575-eaa8-04fb-38f8-f04963792640)
2013-04-11 14:13:14.036+0000: 1856: debug : virUnrefDomain:276 : unref domain 0xc1b450 bs42z98v-01 1
2013-04-11 14:13:14.037+0000: 1856: debug : virReleaseDomain:238 : release domain 0xc1b450 bs42z98v-01 536eb575-eaa8-04fb-38f8-f04963792640
2013-04-11 14:13:14.037+0000: 1856: debug : virReleaseDomain:246 : unref connection 0xbf8720 2
2013-04-11 14:13:14.037+0000: 1856: debug : xenInotifyOpen:407 : Adding a watch on /var/lib/xend/domains
2013-04-11 14:13:14.037+0000: 1856: debug : xenInotifyOpen:419 : Building initial config cache
2013-04-11 14:13:14.037+0000: 1856: debug : xenInotifyOpen:426 : Registering with event loop
2013-04-11 14:13:14.037+0000: 1856: debug : virEventPollInterruptLocked:706 : Interrupting
2013-04-11 14:13:14.037+0000: 1856: debug : virEventPollAddHandle:141 : EVENT_POLL_ADD_HANDLE: watch=3 fd=10 events=1 cb=0x7f09e99dba20 opaque=0xbf8720 ff=(nil)
2013-04-11 14:13:14.037+0000: 1856: debug : xenUnifiedOpen:390 : Activated Xen inotify sub-driver
2013-04-11 14:13:14.037+0000: 1856: debug : do_open:1232 : driver 1 Xen returned SUCCESS
2013-04-11 14:13:14.037+0000: 1856: debug : do_open:1254 : network driver 0 Test returned DECLINED
2013-04-11 14:13:14.037+0000: 1856: debug : do_open:1254 : network driver 1 VBOX returned DECLINED
2013-04-11 14:13:14.037+0000: 1856: debug : doRemoteOpen:542 : proceeding with name = xen:///
2013-04-11 14:13:14.037+0000: 1856: debug : doRemoteOpen:552 : Connecting with transport 1
2013-04-11 14:13:14.037+0000: 1856: debug : doRemoteOpen:599 : Proceeding with sockname /var/run/libvirt/libvirt-sock
2013-04-11 14:13:14.037+0000: 1856: debug : virNetSocketNew:119 : localAddr=0x7fff402d1520 remoteAddr=0x7fff402d1490 fd=11 errfd=-1 pid=0
2013-04-11 14:13:14.037+0000: 1856: debug : virNetSocketNew:179 : RPC_SOCKET_NEW: sock=0xc135e0 refs=1 fd=11 errfd=-1 pid=0 localAddr=127.0.0.1;0, remoteAddr=127.0.0.1;0
2013-04-11 14:13:14.037+0000: 1856: debug : virNetSocketRef:709 : RPC_SOCKET_REF: sock=0xc135e0 refs=2
2013-04-11 14:13:14.037+0000: 1856: debug : virEventPollInterruptLocked:706 : Interrupting
2013-04-11 14:13:14.037+0000: 1856: debug : virEventPollAddHandle:141 : EVENT_POLL_ADD_HANDLE: watch=4 fd=11 events=1 cb=0x7f09e99ba330 opaque=0xc135e0 ff=0x7f09e99bb970
2013-04-11 14:13:14.037+0000: 1856: debug : virKeepAliveNew:244 : client=0x7f09e9d5b010, interval=-1, count=0
2013-04-11 14:13:14.037+0000: 1856: debug : virEventPollAddTimeout:225 : Used 0 timeout slots, adding at least 10 more
2013-04-11 14:13:14.037+0000: 1856: debug : virEventPollInterruptLocked:706 : Interrupting
2013-04-11 14:13:14.037+0000: 1856: debug : virEventPollAddTimeout:248 : EVENT_POLL_ADD_TIMEOUT: timer=1 frequency=-1 cb=0x7f09e99b6690 opaque=0xc113f0 ff=0x7f09e99b6b60
2013-04-11 14:13:14.037+0000: 1856: debug : virKeepAliveNew:277 : RPC_KEEPALIVE_NEW: ka=0xc113f0 client=0x7f09e9d5b010 refs=2
2013-04-11 14:13:14.037+0000: 1856: debug : virNetClientNew:332 : RPC_CLIENT_NEW: client=0x7f09e9d5b010 refs=3 sock=0xc135e0
2013-04-11 14:13:14.037+0000: 1856: debug : doRemoteOpen:684 : Trying authentication
2013-04-11 14:13:14.037+0000: 1856: debug : virNetMessageNew:48 : msg=0x7f09e477b010 tracked=0
2013-04-11 14:13:14.037+0000: 1856: debug : virNetMessageEncodePayload:351 : Encode length as 28
2013-04-11 14:13:14.037+0000: 1856: debug : virNetClientSendInternal:1683 : RPC_CLIENT_MSG_TX_QUEUE: client=0x7f09e9d5b010 len=28 prog=536903814 vers=1 proc=66 type=0 status=0 serial=0
2013-04-11 14:13:14.037+0000: 1856: debug : virNetClientIO:1541 : Outgoing message prog=536903814 version=1 serial=0 proc=66 type=0 length=28 dispatch=(nil)
2013-04-11 14:13:14.037+0000: 1856: debug : virNetClientIO:1599 : We have the buck 0xc11c30 0xc11c30
2013-04-11 14:13:14.037+0000: 1856: debug : virEventPollUpdateHandle:151 : EVENT_POLL_UPDATE_HANDLE: watch=4 events=0
2013-04-11 14:13:14.037+0000: 1856: debug : virEventPollInterruptLocked:706 : Interrupting
2013-04-11 14:13:14.038+0000: 1856: debug : virNetMessageDecodeLength:149 : Got length, now need 36 total (32 more)
2013-04-11 14:13:14.038+0000: 1856: debug : virNetClientCallDispatch:934 : RPC_CLIENT_MSG_RX: client=0x7f09e9d5b010 len=36 prog=536903814 vers=1 proc=66 type=1 status=0 serial=0
2013-04-11 14:13:14.038+0000: 1856: debug : virKeepAliveCheckMessage:424 : ka=0xc113f0, client=0x7f09e9d5b010, msg=0x7f09e9d5b068
2013-04-11 14:13:14.039+0000: 1856: debug : virNetClientIOEventLoopPassTheBuck:1254 : Giving up the buck 0xc11c30
2013-04-11 14:13:14.039+0000: 1856: debug : virNetClientIOEventLoopPassTheBuck:1268 : No thread to pass the buck to
2013-04-11 14:13:14.039+0000: 1856: debug : virEventPollUpdateHandle:151 : EVENT_POLL_UPDATE_HANDLE: watch=4 events=1
2013-04-11 14:13:14.039+0000: 1856: debug : virEventPollInterruptLocked:706 : Interrupting
2013-04-11 14:13:14.039+0000: 1856: debug : virNetClientIO:1628 : All done with our call (nil) 0xc11c30 2
2013-04-11 14:13:14.039+0000: 1856: debug : virNetMessageFree:75 : msg=0x7f09e477b010 nfds=0 cb=(nil)
2013-04-11 14:13:14.039+0000: 1856: debug : virNetMessageNew:48 : msg=0xc1ce50 tracked=0
2013-04-11 14:13:14.039+0000: 1856: debug : virNetMessageEncodePayload:351 : Encode length as 32
2013-04-11 14:13:14.039+0000: 1856: debug : virNetClientSendInternal:1683 : RPC_CLIENT_MSG_TX_QUEUE: client=0x7f09e9d5b010 len=32 prog=536903814 vers=1 proc=60 type=0 status=0 serial=1
2013-04-11 14:13:14.039+0000: 1856: debug : virNetClientIO:1541 : Outgoing message prog=536903814 version=1 serial=1 proc=60 type=0 length=32 dispatch=(nil)
2013-04-11 14:13:14.039+0000: 1856: debug : virNetClientIO:1599 : We have the buck 0xc11c30 0xc11c30
2013-04-11 14:13:14.039+0000: 1856: debug : virEventPollUpdateHandle:151 : EVENT_POLL_UPDATE_HANDLE: watch=4 events=0
2013-04-11 14:13:14.039+0000: 1856: debug : virEventPollInterruptLocked:706 : Interrupting
2013-04-11 14:13:14.041+0000: 1856: debug : virNetMessageDecodeLength:149 : Got length, now need 32 total (28 more)
2013-04-11 14:13:14.041+0000: 1856: debug : virNetClientCallDispatch:934 : RPC_CLIENT_MSG_RX: client=0x7f09e9d5b010 len=32 prog=536903814 vers=1 proc=60 type=1 status=0 serial=1
2013-04-11 14:13:14.041+0000: 1856: debug : virKeepAliveCheckMessage:424 : ka=0xc113f0, client=0x7f09e9d5b010, msg=0x7f09e9d5b068
2013-04-11 14:13:14.041+0000: 1856: debug : virNetClientIOEventLoopPassTheBuck:1254 : Giving up the buck 0xc11c30
2013-04-11 14:13:14.041+0000: 1856: debug : virNetClientIOEventLoopPassTheBuck:1268 : No thread to pass the buck to
2013-04-11 14:13:14.041+0000: 1856: debug : virEventPollUpdateHandle:151 : EVENT_POLL_UPDATE_HANDLE: watch=4 events=1
2013-04-11 14:13:14.041+0000: 1856: debug : virEventPollInterruptLocked:706 : Interrupting
2013-04-11 14:13:14.041+0000: 1856: debug : virNetClientIO:1628 : All done with our call (nil) 0xc11c30 2
2013-04-11 14:13:14.041+0000: 1856: debug : virNetMessageFree:75 : msg=0xc1ce50 nfds=0 cb=(nil)
2013-04-11 14:13:14.041+0000: 1856: debug : doRemoteOpen:710 : Trying to open URI xen:///
2013-04-11 14:13:14.041+0000: 1856: debug : virNetMessageNew:48 : msg=0xc1ce50 tracked=0
2013-04-11 14:13:14.041+0000: 1856: debug : virNetMessageEncodePayload:351 : Encode length as 48
2013-04-11 14:13:14.041+0000: 1856: debug : virNetClientSendInternal:1683 : RPC_CLIENT_MSG_TX_QUEUE: client=0x7f09e9d5b010 len=48 prog=536903814 vers=1 proc=1 type=0 status=0 serial=2
2013-04-11 14:13:14.041+0000: 1856: debug : virNetClientIO:1541 : Outgoing message prog=536903814 version=1 serial=2 proc=1 type=0 length=48 dispatch=(nil)
2013-04-11 14:13:14.041+0000: 1856: debug : virNetClientIO:1599 : We have the buck 0xc11c30 0xc11c30
2013-04-11 14:13:14.041+0000: 1856: debug : virEventPollUpdateHandle:151 : EVENT_POLL_UPDATE_HANDLE: watch=4 events=0
2013-04-11 14:13:14.041+0000: 1856: debug : virEventPollInterruptLocked:706 : Interrupting
2013-04-11 14:13:14.070+0000: 1857: debug : xenStoreDomainIntroduced:1382 : Some domains were missing, trying again
2013-04-11 14:13:14.171+0000: 1857: debug : xenStoreDomainIntroduced:1382 : Some domains were missing, trying again
2013-04-11 14:13:14.272+0000: 1857: debug : xenStoreDomainIntroduced:1382 : Some domains were missing, trying again
2013-04-11 14:13:14.373+0000: 1857: debug : xenStoreDomainIntroduced:1382 : Some domains were missing, trying again
2013-04-11 14:13:14.474+0000: 1857: debug : xenStoreDomainIntroduced:1382 : Some domains were missing, trying again
2013-04-11 14:13:14.575+0000: 1857: debug : xenStoreDomainIntroduced:1382 : Some domains were missing, trying again
2013-04-11 14:13:14.675+0000: 1857: debug : xenStoreDomainIntroduced:1382 : Some domains were missing, trying again
2013-04-11 14:13:14.776+0000: 1857: debug : xenStoreDomainIntroduced:1382 : Some domains were missing, trying again
2013-04-11 14:13:14.877+0000: 1857: debug : xenStoreDomainIntroduced:1382 : Some domains were missing, trying again
2013-04-11 14:13:14.978+0000: 1857: debug : xenStoreDomainIntroduced:1382 : Some domains were missing, trying again
2013-04-11 14:13:15.079+0000: 1857: debug : xenStoreDomainIntroduced:1382 : Some domains were missing, trying again
2013-04-11 14:13:15.180+0000: 1857: debug : xenStoreDomainIntroduced:1382 : Some domains were missing, trying again
2013-04-11 14:13:15.281+0000: 1857: debug : xenStoreDomainIntroduced:1382 : Some domains were missing, trying again
2013-04-11 14:13:15.382+0000: 1857: debug : xenStoreDomainIntroduced:1382 : Some domains were missing, trying again
2013-04-11 14:13:15.483+0000: 1857: debug : xenStoreDomainIntroduced:1382 : Some domains were missing, trying again
2013-04-11 14:13:15.585+0000: 1857: debug : xenStoreDomainIntroduced:1382 : Some domains were missing, trying again
2013-04-11 14:13:15.686+0000: 1857: debug : xenStoreDomainIntroduced:1382 : Some domains were missing, trying again
2013-04-11 14:13:15.787+0000: 1857: debug : xenStoreDomainIntroduced:1382 : Some domains were missing, trying again
2013-04-11 14:13:15.888+0000: 1857: debug : xenStoreDomainIntroduced:1382 : Some domains were missing, trying again
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollCleanupTimeouts:506 : Cleanup 1
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollCleanupHandles:554 : Cleanup 4
2013-04-11 14:13:15.989+0000: 1857: debug : virEventRunDefaultImpl:244 : running default event implementation
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollCleanupTimeouts:506 : Cleanup 1
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollCleanupHandles:554 : Cleanup 4
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollMakePollFDs:383 : Prepare n=0 w=1, f=4 e=1 d=0
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollMakePollFDs:383 : Prepare n=1 w=2, f=8 e=1 d=0
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollMakePollFDs:383 : Prepare n=2 w=3, f=10 e=1 d=0
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollMakePollFDs:383 : Prepare n=3 w=4, f=11 e=0 d=0
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollCalculateTimeout:325 : Calculate expiry of 1 timers
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollCalculateTimeout:351 : Timeout at 0 due in -1 ms
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollRunOnce:619 : EVENT_POLL_RUN: nhandles=3 timeout=-1
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollRunOnce:630 : Poll got 1 event(s)
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollDispatchTimeouts:415 : Dispatch 1
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollDispatchHandles:460 : Dispatch 3
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollDispatchHandles:474 : i=0 w=1
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollDispatchHandles:488 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollDispatchHandles:474 : i=1 w=2
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollDispatchHandles:474 : i=2 w=3
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollCleanupTimeouts:506 : Cleanup 1
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollCleanupHandles:554 : Cleanup 4
2013-04-11 14:13:15.989+0000: 1857: debug : virEventRunDefaultImpl:244 : running default event implementation
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollCleanupTimeouts:506 : Cleanup 1
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollCleanupHandles:554 : Cleanup 4
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollMakePollFDs:383 : Prepare n=0 w=1, f=4 e=1 d=0
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollMakePollFDs:383 : Prepare n=1 w=2, f=8 e=1 d=0
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollMakePollFDs:383 : Prepare n=2 w=3, f=10 e=1 d=0
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollMakePollFDs:383 : Prepare n=3 w=4, f=11 e=0 d=0
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollCalculateTimeout:325 : Calculate expiry of 1 timers
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollCalculateTimeout:351 : Timeout at 0 due in -1 ms
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollRunOnce:619 : EVENT_POLL_RUN: nhandles=3 timeout=-1
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollRunOnce:630 : Poll got 1 event(s)
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollDispatchTimeouts:415 : Dispatch 1
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollDispatchHandles:460 : Dispatch 3
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollDispatchHandles:474 : i=0 w=1
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollDispatchHandles:488 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollDispatchHandles:474 : i=1 w=2
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollDispatchHandles:474 : i=2 w=3
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollCleanupTimeouts:506 : Cleanup 1
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollCleanupHandles:554 : Cleanup 4
2013-04-11 14:13:15.989+0000: 1857: debug : virEventRunDefaultImpl:244 : running default event implementation
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollCleanupTimeouts:506 : Cleanup 1
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollCleanupHandles:554 : Cleanup 4
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollMakePollFDs:383 : Prepare n=0 w=1, f=4 e=1 d=0
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollMakePollFDs:383 : Prepare n=1 w=2, f=8 e=1 d=0
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollMakePollFDs:383 : Prepare n=2 w=3, f=10 e=1 d=0
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollMakePollFDs:383 : Prepare n=3 w=4, f=11 e=0 d=0
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollCalculateTimeout:325 : Calculate expiry of 1 timers
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollCalculateTimeout:351 : Timeout at 0 due in -1 ms
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollRunOnce:619 : EVENT_POLL_RUN: nhandles=3 timeout=-1
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollRunOnce:630 : Poll got 1 event(s)
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollDispatchTimeouts:415 : Dispatch 1
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollDispatchHandles:460 : Dispatch 3
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollDispatchHandles:474 : i=0 w=1
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollDispatchHandles:488 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollDispatchHandles:474 : i=1 w=2
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollDispatchHandles:474 : i=2 w=3
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollCleanupTimeouts:506 : Cleanup 1
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollCleanupHandles:554 : Cleanup 4
2013-04-11 14:13:15.989+0000: 1857: debug : virEventRunDefaultImpl:244 : running default event implementation
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollCleanupTimeouts:506 : Cleanup 1
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollCleanupHandles:554 : Cleanup 4
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollMakePollFDs:383 : Prepare n=0 w=1, f=4 e=1 d=0
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollMakePollFDs:383 : Prepare n=1 w=2, f=8 e=1 d=0
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollMakePollFDs:383 : Prepare n=2 w=3, f=10 e=1 d=0
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollMakePollFDs:383 : Prepare n=3 w=4, f=11 e=0 d=0
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollCalculateTimeout:325 : Calculate expiry of 1 timers
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollCalculateTimeout:351 : Timeout at 0 due in -1 ms
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollRunOnce:619 : EVENT_POLL_RUN: nhandles=3 timeout=-1
2013-04-11 14:13:15.989+0000: 1857: debug : virEventPollRunOnce:630 : Poll got 1 event(s)
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollDispatchTimeouts:415 : Dispatch 1
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollDispatchHandles:460 : Dispatch 3
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollDispatchHandles:474 : i=0 w=1
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollDispatchHandles:488 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollDispatchHandles:474 : i=1 w=2
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollDispatchHandles:474 : i=2 w=3
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollCleanupTimeouts:506 : Cleanup 1
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollCleanupHandles:554 : Cleanup 4
2013-04-11 14:13:15.990+0000: 1857: debug : virEventRunDefaultImpl:244 : running default event implementation
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollCleanupTimeouts:506 : Cleanup 1
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollCleanupHandles:554 : Cleanup 4
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollMakePollFDs:383 : Prepare n=0 w=1, f=4 e=1 d=0
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollMakePollFDs:383 : Prepare n=1 w=2, f=8 e=1 d=0
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollMakePollFDs:383 : Prepare n=2 w=3, f=10 e=1 d=0
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollMakePollFDs:383 : Prepare n=3 w=4, f=11 e=0 d=0
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollCalculateTimeout:325 : Calculate expiry of 1 timers
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollCalculateTimeout:351 : Timeout at 0 due in -1 ms
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollRunOnce:619 : EVENT_POLL_RUN: nhandles=3 timeout=-1
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollRunOnce:630 : Poll got 1 event(s)
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollDispatchTimeouts:415 : Dispatch 1
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollDispatchHandles:460 : Dispatch 3
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollDispatchHandles:474 : i=0 w=1
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollDispatchHandles:488 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollDispatchHandles:474 : i=1 w=2
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollDispatchHandles:474 : i=2 w=3
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollCleanupTimeouts:506 : Cleanup 1
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollCleanupHandles:554 : Cleanup 4
2013-04-11 14:13:15.990+0000: 1857: debug : virEventRunDefaultImpl:244 : running default event implementation
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollCleanupTimeouts:506 : Cleanup 1
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollCleanupHandles:554 : Cleanup 4
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollMakePollFDs:383 : Prepare n=0 w=1, f=4 e=1 d=0
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollMakePollFDs:383 : Prepare n=1 w=2, f=8 e=1 d=0
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollMakePollFDs:383 : Prepare n=2 w=3, f=10 e=1 d=0
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollMakePollFDs:383 : Prepare n=3 w=4, f=11 e=0 d=0
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollCalculateTimeout:325 : Calculate expiry of 1 timers
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollCalculateTimeout:351 : Timeout at 0 due in -1 ms
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollRunOnce:619 : EVENT_POLL_RUN: nhandles=3 timeout=-1
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollRunOnce:630 : Poll got 1 event(s)
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollDispatchTimeouts:415 : Dispatch 1
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollDispatchHandles:460 : Dispatch 3
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollDispatchHandles:474 : i=0 w=1
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollDispatchHandles:488 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollDispatchHandles:474 : i=1 w=2
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollDispatchHandles:474 : i=2 w=3
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollCleanupTimeouts:506 : Cleanup 1
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollCleanupHandles:554 : Cleanup 4
2013-04-11 14:13:15.990+0000: 1857: debug : virEventRunDefaultImpl:244 : running default event implementation
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollCleanupTimeouts:506 : Cleanup 1
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollCleanupHandles:554 : Cleanup 4
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollMakePollFDs:383 : Prepare n=0 w=1, f=4 e=1 d=0
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollMakePollFDs:383 : Prepare n=1 w=2, f=8 e=1 d=0
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollMakePollFDs:383 : Prepare n=2 w=3, f=10 e=1 d=0
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollMakePollFDs:383 : Prepare n=3 w=4, f=11 e=0 d=0
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollCalculateTimeout:325 : Calculate expiry of 1 timers
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollCalculateTimeout:351 : Timeout at 0 due in -1 ms
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollRunOnce:619 : EVENT_POLL_RUN: nhandles=3 timeout=-1
2013-04-11 14:13:15.990+0000: 1857: debug : virEventPollRunOnce:630 : Poll got 1 event(s)
2013-04-11 14:13:15.991+0000: 1857: debug : virEventPollDispatchTimeouts:415 : Dispatch 1
2013-04-11 14:13:15.991+0000: 1857: debug : virEventPollDispatchHandles:460 : Dispatch 3
2013-04-11 14:13:15.991+0000: 1857: debug : virEventPollDispatchHandles:474 : i=0 w=1
2013-04-11 14:13:15.991+0000: 1857: debug : virEventPollDispatchHandles:488 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1
2013-04-11 14:13:15.991+0000: 1857: debug : virEventPollDispatchHandles:474 : i=1 w=2
2013-04-11 14:13:15.991+0000: 1857: debug : virEventPollDispatchHandles:474 : i=2 w=3
2013-04-11 14:13:15.991+0000: 1857: debug : virEventPollCleanupTimeouts:506 : Cleanup 1
2013-04-11 14:13:15.991+0000: 1857: debug : virEventPollCleanupHandles:554 : Cleanup 4
2013-04-11 14:13:15.991+0000: 1857: debug : virEventRunDefaultImpl:244 : running default event implementation
2013-04-11 14:13:15.991+0000: 1857: debug : virEventPollCleanupTimeouts:506 : Cleanup 1
2013-04-11 14:13:15.991+0000: 1857: debug : virEventPollCleanupHandles:554 : Cleanup 4
2013-04-11 14:13:15.992+0000: 1857: debug : virEventPollMakePollFDs:383 : Prepare n=0 w=1, f=4 e=1 d=0
2013-04-11 14:13:15.992+0000: 1857: debug : virEventPollMakePollFDs:383 : Prepare n=1 w=2, f=8 e=1 d=0
2013-04-11 14:13:15.992+0000: 1857: debug : virEventPollMakePollFDs:383 : Prepare n=2 w=3, f=10 e=1 d=0
2013-04-11 14:13:15.992+0000: 1857: debug : virEventPollMakePollFDs:383 : Prepare n=3 w=4, f=11 e=0 d=0
2013-04-11 14:13:15.992+0000: 1857: debug : virEventPollCalculateTimeout:325 : Calculate expiry of 1 timers
2013-04-11 14:13:15.992+0000: 1857: debug : virEventPollCalculateTimeout:351 : Timeout at 0 due in -1 ms
2013-04-11 14:13:15.992+0000: 1857: debug : virEventPollRunOnce:619 : EVENT_POLL_RUN: nhandles=3 timeout=-1
2013-04-11 14:13:15.992+0000: 1857: debug : virEventPollRunOnce:630 : Poll got 1 event(s)
2013-04-11 14:13:15.992+0000: 1857: debug : virEventPollDispatchTimeouts:415 : Dispatch 1
2013-04-11 14:13:15.992+0000: 1857: debug : virEventPollDispatchHandles:460 : Dispatch 3
2013-04-11 14:13:15.993+0000: 1857: debug : virEventPollDispatchHandles:474 : i=0 w=1
2013-04-11 14:13:15.993+0000: 1857: debug : virEventPollDispatchHandles:488 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1
2013-04-11 14:13:15.993+0000: 1857: debug : virEventPollDispatchHandles:474 : i=1 w=2
2013-04-11 14:13:15.993+0000: 1857: debug : virEventPollDispatchHandles:474 : i=2 w=3
2013-04-11 14:13:15.993+0000: 1857: debug : virEventPollCleanupTimeouts:506 : Cleanup 1
2013-04-11 14:13:15.993+0000: 1857: debug : virEventPollCleanupHandles:554 : Cleanup 4
2013-04-11 14:13:15.993+0000: 1857: debug : virEventRunDefaultImpl:244 : running default event implementation
2013-04-11 14:13:15.993+0000: 1857: debug : virEventPollCleanupTimeouts:506 : Cleanup 1
2013-04-11 14:13:15.993+0000: 1857: debug : virEventPollCleanupHandles:554 : Cleanup 4
2013-04-11 14:13:15.993+0000: 1857: debug : virEventPollMakePollFDs:383 : Prepare n=0 w=1, f=4 e=1 d=0
2013-04-11 14:13:15.994+0000: 1857: debug : virEventPollMakePollFDs:383 : Prepare n=1 w=2, f=8 e=1 d=0
2013-04-11 14:13:15.994+0000: 1857: debug : virEventPollMakePollFDs:383 : Prepare n=2 w=3, f=10 e=1 d=0
2013-04-11 14:13:15.994+0000: 1857: debug : virEventPollMakePollFDs:383 : Prepare n=3 w=4, f=11 e=0 d=0
2013-04-11 14:13:15.994+0000: 1857: debug : virEventPollCalculateTimeout:325 : Calculate expiry of 1 timers
2013-04-11 14:13:15.994+0000: 1857: debug : virEventPollCalculateTimeout:351 : Timeout at 0 due in -1 ms
2013-04-11 14:13:15.994+0000: 1857: debug : virEventPollRunOnce:619 : EVENT_POLL_RUN: nhandles=3 timeout=-1
2013-04-11 14:13:16.300+0000: 1856: debug : virNetMessageDecodeLength:149 : Got length, now need 28 total (24 more)
2013-04-11 14:13:16.300+0000: 1856: debug : virNetClientCallDispatch:934 : RPC_CLIENT_MSG_RX: client=0x7f09e9d5b010 len=28 prog=536903814 vers=1 proc=1 type=1 status=0 serial=2
2013-04-11 14:13:16.300+0000: 1856: debug : virKeepAliveCheckMessage:424 : ka=0xc113f0, client=0x7f09e9d5b010, msg=0x7f09e9d5b068
2013-04-11 14:13:16.300+0000: 1856: debug : virNetClientIOEventLoopPassTheBuck:1254 : Giving up the buck 0xc11c30
2013-04-11 14:13:16.300+0000: 1856: debug : virNetClientIOEventLoopPassTheBuck:1268 : No thread to pass the buck to
2013-04-11 14:13:16.300+0000: 1856: debug : virEventPollUpdateHandle:151 : EVENT_POLL_UPDATE_HANDLE: watch=4 events=1
2013-04-11 14:13:16.300+0000: 1856: debug : virEventPollInterruptLocked:706 : Interrupting
2013-04-11 14:13:16.300+0000: 1856: debug : virNetClientIO:1628 : All done with our call (nil) 0xc11c30 2
2013-04-11 14:13:16.300+0000: 1856: debug : virNetMessageFree:75 : msg=0xc1ce50 nfds=0 cb=(nil)
2013-04-11 14:13:16.300+0000: 1856: debug : do_open:1254 : network driver 2 remote returned SUCCESS
2013-04-11 14:13:16.300+0000: 1856: debug : do_open:1269 : interface driver 0 Test returned DECLINED
2013-04-11 14:13:16.300+0000: 1856: debug : do_open:1269 : interface driver 1 remote returned SUCCESS
2013-04-11 14:13:16.300+0000: 1856: debug : do_open:1285 : storage driver 0 Test returned DECLINED
2013-04-11 14:13:16.300+0000: 1856: debug : do_open:1285 : storage driver 1 VBOX returned DECLINED
2013-04-11 14:13:16.300+0000: 1856: debug : do_open:1285 : storage driver 2 remote returned SUCCESS
2013-04-11 14:13:16.300+0000: 1856: debug : do_open:1301 : node driver 0 Test returned DECLINED
2013-04-11 14:13:16.300+0000: 1856: debug : do_open:1301 : node driver 1 remote returned SUCCESS
2013-04-11 14:13:16.300+0000: 1856: debug : do_open:1317 : secret driver 0 Test returned DECLINED
2013-04-11 14:13:16.300+0000: 1856: debug : do_open:1317 : secret driver 1 remote returned SUCCESS
2013-04-11 14:13:16.300+0000: 1856: debug : do_open:1333 : nwfilter driver 0 Test returned DECLINED
2013-04-11 14:13:16.300+0000: 1856: debug : do_open:1333 : nwfilter driver 1 remote returned SUCCESS
2013-04-11 14:13:16.300+0000: 1857: debug : virEventPollRunOnce:630 : Poll got 1 event(s)
2013-04-11 14:13:16.301+0000: 1856: debug : virDomainDefineXML:7907 : conn=0xbf8720, xml=<domain type='xen'>
  <name>ucs31-64-steuwer</name>
  <uuid>284afb36-8940-5a5f-f5f3-d4df7e6b8255</uuid>
  <memory unit='KiB'>524288</memory>
  <currentMemory unit='KiB'>524288</currentMemory>
  <vcpu placement='static'>1</vcpu>
  <bootloader>/usr/bin/pygrub</bootloader>
  <bootloader_args>-q</bootloader_args>
  <os>
    <type>linux</type>
  </os>
  <clock offset='utc' adjustment='reset'/>
  <on_poweroff>destroy</on_poweroff>
  <on_reboot>restart</on_reboot>
  <on_crash>destroy</on_crash>
  <devices>
    <emulator>/usr/lib/xen/bin/qemu-dm</emulator>
    <disk type='file' device='disk'>
      <driver name='tap2' type='aio'/>
      <source file='/var/lib/libvirt/images/ucs31-64-steuwer-0.img'/>
      <target dev='xvda' bus='xen'/>
    </disk>
    <interface type='bridge'>
      <mac address='00:16:3e:06:6a:b6'/>
      <source bridge='eth0'/>
      <script path='vif-bridge'/>
      <model type='netfront'/>
    </interface>
    <console type='pty'>
      <target type='xen' port='0'/>
    </console>
    <input type='mouse' bus='xen'/>
    <graphics type='vnc' port='-1' autoport='yes' listen='0.0.0.0' keymap='en-us'>
      <listen type='address' address='0.0.0.0'/>
    </graphics>
  </devices>
</domain>


2013-04-11 14:13:16.301+0000: 1857: debug : virEventPollDispatchTimeouts:415 : Dispatch 1
2013-04-11 14:13:16.301+0000: 1857: debug : virEventPollDispatchHandles:460 : Dispatch 3
2013-04-11 14:13:16.301+0000: 1857: debug : virEventPollDispatchHandles:474 : i=0 w=1
2013-04-11 14:13:16.301+0000: 1857: debug : virEventPollDispatchHandles:488 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1
2013-04-11 14:13:16.301+0000: 1857: debug : virEventPollDispatchHandles:474 : i=1 w=2
2013-04-11 14:13:16.301+0000: 1857: debug : virEventPollDispatchHandles:474 : i=2 w=3
2013-04-11 14:13:16.301+0000: 1857: debug : virEventPollCleanupTimeouts:506 : Cleanup 1
2013-04-11 14:13:16.301+0000: 1857: debug : virEventPollCleanupHandles:554 : Cleanup 4
2013-04-11 14:13:16.301+0000: 1857: debug : virEventRunDefaultImpl:244 : running default event implementation
2013-04-11 14:13:16.301+0000: 1857: debug : virEventPollCleanupTimeouts:506 : Cleanup 1
2013-04-11 14:13:16.301+0000: 1857: debug : virEventPollCleanupHandles:554 : Cleanup 4
2013-04-11 14:13:16.301+0000: 1857: debug : virEventPollMakePollFDs:383 : Prepare n=0 w=1, f=4 e=1 d=0
2013-04-11 14:13:16.301+0000: 1857: debug : virEventPollMakePollFDs:383 : Prepare n=1 w=2, f=8 e=1 d=0
2013-04-11 14:13:16.301+0000: 1857: debug : virEventPollMakePollFDs:383 : Prepare n=2 w=3, f=10 e=1 d=0
2013-04-11 14:13:16.301+0000: 1857: debug : virEventPollMakePollFDs:383 : Prepare n=3 w=4, f=11 e=1 d=0
2013-04-11 14:13:16.301+0000: 1857: debug : virEventPollCalculateTimeout:325 : Calculate expiry of 1 timers
2013-04-11 14:13:16.301+0000: 1857: debug : virEventPollCalculateTimeout:351 : Timeout at 0 due in -1 ms
2013-04-11 14:13:16.301+0000: 1857: debug : virEventPollRunOnce:619 : EVENT_POLL_RUN: nhandles=4 timeout=-1
2013-04-11 14:13:16.302+0000: 1856: debug : xenFormatSxpr:2235 : Formatting domain sexpr
2013-04-11 14:13:16.302+0000: 1856: debug : xenFormatSxpr:2597 : Formatted sexpr: 
(vm (name 'ucs31-64-steuwer')(memory 512)(maxmem 512)(vcpus 1)(uuid '284afb36-8940-5a5f-f5f3-d4df7e6b8255')(bootloader '/usr/bin/pygrub')(bootloader_args '-q')(on_poweroff 'destroy')(on_reboot 'restart')(on_crash 'destroy')(image (linux (localtime 0)))(localtime 0)(device (tap2 (dev 'xvda')(uname 'tap2:aio:/var/lib/libvirt/images/ucs31-64-steuwer-0.img')(mode 'w')))(device (vif (mac '00:16:3e:06:6a:b6')(bridge 'eth0')(script 'vif-bridge')(model 'netfront')))(device (vkbd))(device (vfb (type vnc)(vncunused 1)(vnclisten '0.0.0.0')(keymap 'en-us'))))
2013-04-11 14:13:16.302+0000: 1856: debug : xend_op_ext:506 : xend op: op=new&config=%28vm%20%28name%20%27ucs31%2d64%2dsteuwer%27%29%28memory%20512%29%28maxmem%20512%29%28vcpus%201%29%28uuid%20%27284afb36%2d8940%2d5a5f%2df5f3%2dd4df7e6b8255%27%29%28bootloader%20%27%2fusr%2fbin%2fpygrub%27%29%28bootloader%5fargs%20%27%2dq%27%29%28on%5fpoweroff%20%27destroy%27%29%28on%5freboot%20%27restart%27%29%28on%5fcrash%20%27destroy%27%29%28image%20%28linux%20%28localtime%200%29%29%29%28localtime%200%29%28device%20%28tap2%20%28dev%20%27xvda%27%29%28uname%20%27tap2%3aaio%3a%2fvar%2flib%2flibvirt%2fimages%2fucs31%2d64%2dsteuwer%2d0%2eimg%27%29%28mode%20%27w%27%29%29%29%28device%20%28vif%20%28mac%20%2700%3a16%3a3e%3a06%3a6a%3ab6%27%29%28bridge%20%27eth0%27%29%28script%20%27vif%2dbridge%27%29%28model%20%27netfront%27%29%29%29%28device%20%28vkbd%29%29%28device%20%28vfb%20%28type%20vnc%29%28vncunused%201%29%28vnclisten%20%270%2e0%2e0%2e0%27%29%28keymap%20%27en%2dus%27%29%29%29%29

2013-04-11 14:13:16.313+0000: 1857: debug : virEventPollRunOnce:630 : Poll got 1 event(s)
2013-04-11 14:13:16.313+0000: 1857: debug : virEventPollDispatchTimeouts:415 : Dispatch 1
2013-04-11 14:13:16.313+0000: 1857: debug : virEventPollDispatchHandles:460 : Dispatch 4
2013-04-11 14:13:16.313+0000: 1857: debug : virEventPollDispatchHandles:474 : i=0 w=1
2013-04-11 14:13:16.314+0000: 1857: debug : virEventPollDispatchHandles:474 : i=1 w=2
2013-04-11 14:13:16.314+0000: 1857: debug : virEventPollDispatchHandles:474 : i=2 w=3
2013-04-11 14:13:16.314+0000: 1857: debug : virEventPollDispatchHandles:488 : EVENT_POLL_DISPATCH_HANDLE: watch=3 events=1
2013-04-11 14:13:16.314+0000: 1857: debug : xenInotifyEvent:255 : got inotify event
2013-04-11 14:13:16.314+0000: 1857: debug : xenInotifyXendDomainsDirLookup:101 : Looking for dom with uuid: 284afb36-8940-5a5f-f5f3-d4df7e6b8255
2013-04-11 14:13:16.329+0000: 1856: debug : virDomainLookupByName:2178 : conn=0xbf8720, name=ucs31-64-steuwer
2013-04-11 14:13:16.340+0000: 1857: debug : virDomainFree:2345 : dom=0x7f09e0002c80, (VM: name=ucs31-64-steuwer, uuid=284afb36-8940-5a5f-f5f3-d4df7e6b8255)
2013-04-11 14:13:16.340+0000: 1857: debug : virUnrefDomain:276 : unref domain 0x7f09e0002c80 ucs31-64-steuwer 1
2013-04-11 14:13:16.340+0000: 1857: debug : virReleaseDomain:238 : release domain 0x7f09e0002c80 ucs31-64-steuwer 284afb36-8940-5a5f-f5f3-d4df7e6b8255
2013-04-11 14:13:16.340+0000: 1857: debug : virReleaseDomain:246 : unref connection 0xbf8720 2
2013-04-11 14:13:16.340+0000: 1857: debug : xenInotifyXendDomainsDirLookup:101 : Looking for dom with uuid: 284afb36-8940-5a5f-f5f3-d4df7e6b8255
2013-04-11 14:13:16.346+0000: 1856: debug : virDomainGetName:3465 : domain=0xc1b180
Domain ucs31-64-steuwer defined from ucs31-64-steuwer.xml
2013-04-11 14:13:16.346+0000: 1856: debug : virDomainFree:2345 : dom=0xc1b180, (VM: name=ucs31-64-steuwer, uuid=284afb36-8940-5a5f-f5f3-d4df7e6b8255)
2013-04-11 14:13:16.346+0000: 1856: debug : virUnrefDomain:276 : unref domain 0xc1b180 ucs31-64-steuwer 1
2013-04-11 14:13:16.346+0000: 1856: debug : virReleaseDomain:238 : release domain 0xc1b180 ucs31-64-steuwer 284afb36-8940-5a5f-f5f3-d4df7e6b8255
2013-04-11 14:13:16.346+0000: 1856: debug : virReleaseDomain:246 : unref connection 0xbf8720 2

2013-04-11 14:13:16.346+0000: 1856: debug : virConnectClose:1496 : conn=0xbf8720
2013-04-11 14:13:16.346+0000: 1856: debug : virUnrefConnect:145 : unref connection 0xbf8720 1
2013-04-11 14:13:16.346+0000: 1856: debug : virReleaseConnect:94 : release connection 0xbf8720
2013-04-11 14:13:16.346+0000: 1856: debug : virNetMessageNew:48 : msg=0xc1ce50 tracked=0
2013-04-11 14:13:16.346+0000: 1856: debug : virNetMessageEncodePayload:351 : Encode length as 28
2013-04-11 14:13:16.346+0000: 1856: debug : virNetClientSendInternal:1683 : RPC_CLIENT_MSG_TX_QUEUE: client=0x7f09e9d5b010 len=28 prog=536903814 vers=1 proc=2 type=0 status=0 serial=3
2013-04-11 14:13:16.346+0000: 1856: debug : virNetClientIO:1541 : Outgoing message prog=536903814 version=1 serial=3 proc=2 type=0 length=28 dispatch=(nil)
2013-04-11 14:13:16.346+0000: 1856: debug : virNetClientIO:1599 : We have the buck 0xc12d10 0xc12d10
2013-04-11 14:13:16.346+0000: 1856: debug : virEventPollUpdateHandle:151 : EVENT_POLL_UPDATE_HANDLE: watch=4 events=0
2013-04-11 14:13:16.346+0000: 1856: debug : virEventPollInterruptLocked:706 : Interrupting
2013-04-11 14:13:16.356+0000: 1857: debug : virDomainFree:2345 : dom=0xbf8570, (VM: name=ucs31-64-steuwer, uuid=284afb36-8940-5a5f-f5f3-d4df7e6b8255)
2013-04-11 14:13:16.356+0000: 1857: debug : virUnrefDomain:276 : unref domain 0xbf8570 ucs31-64-steuwer 1
2013-04-11 14:13:16.356+0000: 1857: debug : virReleaseDomain:238 : release domain 0xbf8570 ucs31-64-steuwer 284afb36-8940-5a5f-f5f3-d4df7e6b8255
2013-04-11 14:13:16.356+0000: 1857: debug : virReleaseDomain:246 : unref connection 0xbf8720 1
2013-04-11 14:13:16.356+0000: 1857: debug : virReleaseConnect:94 : release connection 0xbf8720
2013-04-11 14:13:16.357+0000: 1857: debug : virNetMessageNew:48 : msg=0xc5cec0 tracked=0
2013-04-11 14:13:16.357+0000: 1857: debug : virNetMessageEncodePayload:351 : Encode length as 28
2013-04-11 14:13:16.357+0000: 1857: debug : virNetClientSendInternal:1683 : RPC_CLIENT_MSG_TX_QUEUE: client=0x7f09e9d5b010 len=28 prog=536903814 vers=1 proc=2 type=0 status=0 serial=4
2013-04-11 14:13:16.357+0000: 1857: debug : virNetClientIO:1541 : Outgoing message prog=536903814 version=1 serial=4 proc=2 type=0 length=28 dispatch=0xc12d10
2013-04-11 14:13:16.357+0000: 1857: debug : virNetClientIO:1558 : Going to sleep 0xc12d10 0xc12d70
2013-04-11 14:13:16.357+0000: 1856: debug : virNetClientIOEventLoop:1377 : Woken up from poll by other thread
2013-04-11 14:13:16.368+0000: 1856: debug : virNetMessageDecodeLength:149 : Got length, now need 28 total (24 more)
2013-04-11 14:13:16.368+0000: 1856: debug : virNetClientCallDispatch:934 : RPC_CLIENT_MSG_RX: client=0x7f09e9d5b010 len=28 prog=536903814 vers=1 proc=2 type=1 status=0 serial=3
2013-04-11 14:13:16.368+0000: 1856: debug : virKeepAliveCheckMessage:424 : ka=0xc113f0, client=0x7f09e9d5b010, msg=0x7f09e9d5b068
2013-04-11 14:13:16.368+0000: 1856: debug : virNetClientIOEventLoopPassTheBuck:1254 : Giving up the buck 0xc12d10
2013-04-11 14:13:16.368+0000: 1856: debug : virNetClientIOEventLoopPassTheBuck:1260 : Passing the buck to 0xc12d70
2013-04-11 14:13:16.368+0000: 1856: debug : virEventPollUpdateHandle:151 : EVENT_POLL_UPDATE_HANDLE: watch=4 events=1
2013-04-11 14:13:16.368+0000: 1856: debug : virEventPollInterruptLocked:706 : Interrupting
2013-04-11 14:13:16.368+0000: 1856: debug : virNetClientIO:1628 : All done with our call 0xc12d70 0xc12d10 2
2013-04-11 14:13:16.368+0000: 1856: debug : virNetMessageFree:75 : msg=0xc1ce50 nfds=0 cb=(nil)
2013-04-11 14:13:16.368+0000: 1856: debug : virNetClientClose:521 : client=0x7f09e9d5b010
2013-04-11 14:13:16.368+0000: 1856: debug : virNetClientFree:454 : RPC_CLIENT_FREE: client=0x7f09e9d5b010 refs=3
2013-04-11 14:13:16.368+0000: 1857: debug : virNetClientIO:1567 : Wokeup from sleep 0xc12d70 0xc12d70
2013-04-11 14:13:16.368+0000: 1857: debug : virNetClientIO:1599 : We have the buck 0xc12d70 0xc12d70
2013-04-11 14:13:16.368+0000: 1857: debug : virEventPollUpdateHandle:151 : EVENT_POLL_UPDATE_HANDLE: watch=4 events=0
2013-04-11 14:13:16.368+0000: 1857: debug : virEventPollInterruptLocked:702 : Skip interrupt, 1 -444868864
2013-04-11 14:13:16.368+0000: 1857: debug : virNetClientIOEventLoop:1377 : Woken up from poll by other thread
2013-04-11 14:13:16.368+0000: 1857: debug : virNetClientIOEventLoopPassTheBuck:1254 : Giving up the buck 0xc12d70
2013-04-11 14:13:16.368+0000: 1857: debug : virNetClientIOEventLoopPassTheBuck:1268 : No thread to pass the buck to
2013-04-11 14:13:16.368+0000: 1857: debug : virNetClientCloseLocked:489 : client=0x7f09e9d5b010, sock=0xc135e0
2013-04-11 14:13:16.368+0000: 1857: debug : virEventPollRemoveHandle:180 : EVENT_POLL_REMOVE_HANDLE: watch=4
2013-04-11 14:13:16.368+0000: 1857: debug : virEventPollRemoveHandle:193 : mark delete 3 11
2013-04-11 14:13:16.368+0000: 1857: debug : virEventPollInterruptLocked:702 : Skip interrupt, 1 -444868864
2013-04-11 14:13:16.368+0000: 1857: debug : virNetSocketFree:722 : RPC_SOCKET_FREE: sock=0xc135e0 refs=2
2013-04-11 14:13:16.368+0000: 1857: debug : virKeepAliveStopInternal:382 : RPC_KEEPALIVE_STOP: ka=0xc113f0 client=0x7f09e9d5b010 all=1
2013-04-11 14:13:16.368+0000: 1857: debug : virEventPollRemoveTimeout:293 : EVENT_POLL_REMOVE_TIMEOUT: timer=1
2013-04-11 14:13:16.368+0000: 1857: debug : virEventPollInterruptLocked:702 : Skip interrupt, 1 -444868864
2013-04-11 14:13:16.368+0000: 1857: debug : virKeepAliveFree:304 : RPC_KEEPALIVE_FREE: ka=0xc113f0 client=0x7f09e9d5b010 refs=2
2013-04-11 14:13:16.368+0000: 1857: debug : virNetClientIO:1628 : All done with our call (nil) 0xc12d70 -1
2013-04-11 14:13:16.369+0000: 1857: debug : virNetMessageFree:75 : msg=0xc5cec0 nfds=0 cb=(nil)
2013-04-11 14:13:16.369+0000: 1857: debug : virNetClientClose:521 : client=(nil)
*** glibc detected *** virsh: double free or corruption (!prev): 0x0000000000c13390 ***
======= Backtrace: =========
/lib/libc.so.6(+0x71e16)[0x7f09e674de16]
/lib/libc.so.6(cfree+0x6c)[0x7f09e6752b8c]
/usr/lib/libvirt.so.0(virFree+0x39)[0x7f09e98c5199]
/usr/lib/libvirt.so.0(+0x1216ff)[0x7f09e998c6ff]
/usr/lib/libvirt.so.0(+0xe0a05)[0x7f09e994ba05]
/usr/lib/libvirt.so.0(+0xe0bf8)[0x7f09e994bbf8]
/usr/lib/libvirt.so.0(virUnrefDomain+0xc8)[0x7f09e994bed8]
/usr/lib/libvirt.so.0(virDomainFree+0xbb)[0x7f09e9977feb]
/usr/lib/libvirt.so.0(+0x17010c)[0x7f09e99db10c]
/usr/lib/libvirt.so.0(+0x1709bc)[0x7f09e99db9bc]
/usr/lib/libvirt.so.0(+0x170d00)[0x7f09e99dbd00]
/usr/lib/libvirt.so.0(+0x51e15)[0x7f09e98bce15]
/usr/lib/libvirt.so.0(virEventRunDefaultImpl+0x45)[0x7f09e98bba45]
virsh[0x41eb52]
/usr/lib/libvirt.so.0(+0x64ba6)[0x7f09e98cfba6]
/lib/libpthread.so.0(+0x68ca)[0x7f09e73e08ca]
/lib/libc.so.6(clone+0x6d)[0x7f09e67abb6d]
======= Memory map: ========
00400000-00450000 r-xp 00000000 fe:00 1610687521                         /usr/bin/virsh
0064f000-00651000 rw-p 0004f000 fe:00 1610687521                         /usr/bin/virsh
00bcb000-00c3d000 rw-p 00000000 00:00 0                                  [heap]
7f09e0000000-7f09e0021000 rw-p 00000000 00:00 0 
7f09e0021000-7f09e4000000 ---p 00000000 00:00 0 
7f09e45a6000-7f09e45bc000 r-xp 00000000 fe:00 537081246                  /lib/libgcc_s.so.1
7f09e45bc000-7f09e47bb000 ---p 00016000 fe:00 537081246                  /lib/libgcc_s.so.1
7f09e47bb000-7f09e47bc000 rw-p 00015000 fe:00 537081246                  /lib/libgcc_s.so.1
7f09e47bc000-7f09e47bd000 ---p 00000000 00:00 0 
7f09e47bd000-7f09e4fbd000 rw-p 00000000 00:00 0 
7f09e4fbd000-7f09e4fbe000 ---p 00000000 00:00 0 
7f09e4fbe000-7f09e57be000 rw-p 00000000 00:00 0 
7f09e57be000-7f09e5800000 r-xp 00000000 fe:00 537081479                  /lib/libncurses.so.5.7
7f09e5800000-7f09e59ff000 ---p 00042000 fe:00 537081479                  /lib/libncurses.so.5.7
7f09e59ff000-7f09e5a04000 rw-p 00041000 fe:00 537081479                  /lib/libncurses.so.5.7
7f09e5a04000-7f09e5a84000 r-xp 00000000 fe:00 537081227                  /lib/libm-2.11.3.so
7f09e5a84000-7f09e5c84000 ---p 00080000 fe:00 537081227                  /lib/libm-2.11.3.so
7f09e5c84000-7f09e5c85000 r--p 00080000 fe:00 537081227                  /lib/libm-2.11.3.so
7f09e5c85000-7f09e5c86000 rw-p 00081000 fe:00 537081227                  /lib/libm-2.11.3.so
7f09e5c86000-7f09e5c89000 r-xp 00000000 fe:00 1074340695                 /usr/lib/libgpg-error.so.0.4.0
7f09e5c89000-7f09e5e88000 ---p 00003000 fe:00 1074340695                 /usr/lib/libgpg-error.so.0.4.0
7f09e5e88000-7f09e5e89000 rw-p 00002000 fe:00 1074340695                 /usr/lib/libgpg-error.so.0.4.0
7f09e5e89000-7f09e5ea0000 r-xp 00000000 fe:00 1074374365                 /usr/lib/libz.so.1.2.3.4
7f09e5ea0000-7f09e609f000 ---p 00017000 fe:00 1074374365                 /usr/lib/libz.so.1.2.3.4
7f09e609f000-7f09e60a0000 rw-p 00016000 fe:00 1074374365                 /usr/lib/libz.so.1.2.3.4
7f09e60a0000-7f09e60b0000 r-xp 00000000 fe:00 1074341381                 /usr/lib/libtasn1.so.3.1.9
7f09e60b0000-7f09e62af000 ---p 00010000 fe:00 1074341381                 /usr/lib/libtasn1.so.3.1.9
7f09e62af000-7f09e62b0000 rw-p 0000f000 fe:00 1074341381                 /usr/lib/libtasn1.so.3.1.9
7f09e62b0000-7f09e62bd000 r-xp 00000000 fe:00 537101844                  /lib/libudev.so.0.9.3
7f09e62bd000-7f09e64bc000 ---p 0000d000 fe:00 537101844                  /lib/libudev.so.0.9.3
7f09e64bc000-7f09e64bd000 r--p 0000c000 fe:00 537101844                  /lib/libudev.so.0.9.3
7f09e64bd000-7f09e64be000 rw-p 0000d000 fe:00 537101844                  /lib/libudev.so.0.9.3
7f09e64be000-7f09e64da000 r-xp 00000000 fe:00 537101831                  /lib/libselinux.so.1
7f09e64da000-7f09e66d9000 ---p 0001c000 fe:00 537101831                  /lib/libselinux.so.1
7f09e66d9000-7f09e66da000 r--p 0001b000 fe:00 537101831                  /lib/libselinux.so.1
7f09e66da000-7f09e66db000 rw-p 0001c000 fe:00 537101831                  /lib/libselinux.so.1
7f09e66db000-7f09e66dc000 rw-p 00000000 00:00 0 
7f09e66dc000-7f09e6835000 r-xp 00000000 fe:00 537081225                  /lib/libc-2.11.3.so
7f09e6835000-7f09e6a34000 ---p 00159000 fe:00 537081225                  /lib/libc-2.11.3.so
7f09e6a34000-7f09e6a38000 r--p 00158000 fe:00 537081225                  /lib/libc-2.11.3.so
7f09e6a38000-7f09e6a39000 rw-p 0015c000 fe:00 537081225                  /lib/libc-2.11.3.so
7f09e6a39000-7f09e6a3e000 rw-p 00000000 00:00 0 
7f09e6a3e000-7f09e6a40000 r-xp 00000000 fe:00 537081226                  /lib/libdl-2.11.3.so
7f09e6a40000-7f09e6c40000 ---p 00002000 fe:00 537081226                  /lib/libdl-2.11.3.soAborted