1. 2013-05-07 16:22:39.879+0000: 16656: info : libvirt version: 0.9.8
  2. 2013-05-07 16:22:39.879+0000: 16656: warning : qemuDomainObjTaint:1134 : Domain id=1 name='uno' uuid=fc093b54-5e91-9890-d48e-790b15bfe5f1 is tainted: high-privileges
  3. 2013-05-07 16:27:59.682+0000: 16651: error : qemuMonitorIO:560 : internal error End of file from monitor
  4. Caught Segmentation violation dumping internal log buffer:
  5. 
  6. 
  7. ====== start of log =====
  8. 
  9. \00tPollDispatchHandles:474 : i=6 w=7
  10. 2013-05-07 16:27:46.711+000016651: debug : virEventPollDispatchHandles:488 : EVENT_POLL_DISPATCH_HANDLE: watch=7 events=2
  11. 2013-05-07 16:27:46.711+000016651: debug : virNetMessageFree:75 : msg=0x9fef230 nfds=0 cb=(nil)
  12. 2013-05-07 16:27:46.711+000016651: debug : virNetServerClientCalculateHandleMode:137 : tls=(nil) hs=-1, rx=0x9faf1e8 tx=(nil)
  13. 2013-05-07 16:27:46.711+000016651: debug : virNetServerClientCalculateHandleMode:167 : mode=1
  14. 2013-05-07 16:27:46.711+000016651: debug : virEventPollUpdateHandle:151 : EVENT_POLL_UPDATE_HANDLE: watch=7 events=1
  15. 2013-05-07 16:27:46.711+000016651: debug : virEventPollInterruptLocked:702 : Skip interrupt, 1 -1231796416
  16. 2013-05-07 16:27:46.711+000016651: debug : virEventPollDispatchHandles:474 : i=7 w=8
  17. 2013-05-07 16:27:46.711+000016651: debug : virEventPollCleanupTimeouts:506 : Cleanup 6
  18. 2013-05-07 16:27:46.711+000016651: debug : virEventPollCleanupHandles:554 : Cleanup 8
  19. 2013-05-07 16:27:46.711+000016651: debug : virEventRunDefaultImpl:244 : running default event implementation
  20. 2013-05-07 16:27:46.711+000016651: debug : virEventPollCleanupTimeouts:506 : Cleanup 6
  21. 2013-05-07 16:27:46.711+000016651: debug : virEventPollCleanupHandles:554 : Cleanup 8
  22. 2013-05-07 16:27:46.711+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=0 w=1, f=7 e=1 d=0
  23. 2013-05-07 16:27:46.711+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=1 w=2, f=9 e=1 d=0
  24. 2013-05-07 16:27:46.711+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=2 w=3, f=11 e=1 d=0
  25. 2013-05-07 16:27:46.711+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=3 w=4, f=12 e=1 d=0
  26. 2013-05-07 16:27:46.711+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=4 w=5, f=13 e=1 d=0
  27. 2013-05-07 16:27:46.711+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=5 w=6, f=14 e=1 d=0
  28. 2013-05-07 16:27:46.711+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=6 w=7, f=15 e=1 d=0
  29. 2013-05-07 16:27:46.711+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=7 w=8, f=18 e=25 d=0
  30. 2013-05-07 16:27:46.711+000016651: debug : virEventPollCalculateTimeout:325 : Calculate expiry of 6 timers
  31. 2013-05-07 16:27:46.711+000016651: debug : virEventPollCalculateTimeout:331 : Got a timeout scheduled for 1367944071710
  32. 2013-05-07 16:27:46.711+000016651: debug : virEventPollCalculateTimeout:351 : Timeout at 1367944071710 due in 4999 ms
  33. 2013-05-07 16:27:46.711+000016651: debug : virEventPollRunOnce:619 : EVENT_POLL_RUN: nhandles=8 imeout=4999
  34. 2013-05-07 16:27:46.741+000016651: debug : virEventPollRunOnce:630 : Poll got 1 event(s)
  35. 2013-05-07 16:27:46.741+000016651: debug : virEventPollDispatchTimeouts:415 : Dispatch 6
  36. 2013-05-07 16:27:46.741+000016651: debug : virEventPollDispatchHandles:460 : Dispatch 8
  37. 2013-05-07 16:27:46.741+000016651: debug : virEventPollDispatchHandles:474 : i=0 w=1
  38. 2013-05-07 16:27:46.741+000016651: debug : virEventPollDispatchHandles:474 : i=1 w=2
  39. 2013-05-07 16:27:46.741+000016651: debug : virEventPollDispatchHandles:474 : i=2 w=3
  40. 2013-05-07 16:27:46.741+000016651: debug : virEventPollDispatchHandles:474 : i=3 w=4
  41. 2013-05-07 16:27:46.741+000016651: debug : virEventPollDispatchHandles:474 : i=4 w=5
  42. 2013-05-07 16:27:46.741+000016651: debug : virEventPollDispatchHandles:474 : i=5 w=6
  43. 2013-05-07 16:27:46.741+000016651: debug : virEventPollDispatchHandles:474 : i=6 w=7
  44. 2013-05-07 16:27:46.741+000016651: debug : virEventPollDispatchHandles:488 : EVENT_POLL_DISPATCH_HANDLE: watch=7 events=1
  45. 2013-05-07 16:27:46.741+000016651: debug : virNetMessageDecodeLength:149 : Got length, now need 28 total (24 more)
  46. 2013-05-07 16:27:46.741+000016651: debug : virNetServerClientCalculateHandleMode:137 : tls=(nil) hs=-1, rx=0x9faf1e8 tx=(nil)
  47. 2013-05-07 16:27:46.741+000016651: debug : virNetServerClientCalculateHandleMode:167 : mode=1
  48. 2013-05-07 16:27:46.741+000016651: debug : virEventPollUpdateHandle:151 : EVENT_POLL_UPDATE_HANDLE: watch=7 events=1
  49. 2013-05-07 16:27:46.741+000016651: debug : virEventPollInterruptLocked:702 : Skip interrupt, 1 -1231796416
  50. 2013-05-07 16:27:46.741+000016651: debug : virNetServerClientDispatchRead:886 : RPC_SERVER_CLIENT_MSG_RX: client=0x9f9c638 len=28 prog=1801807216 vers=1 proc=2 type=2 status=0 serial=0
  51. 2013-05-07 16:27:46.741+000016651: debug : virKeepAliveCheckMessage:408 : ka=0x9f95908, client=0x9f9c638, msg=0x9faf1e8
  52. 2013-05-07 16:27:46.741+000016651: debug : virKeepAliveCheckMessage:424 : RPC_KEEPALIVE_RECEIVED: ka=0x9f95908 client=0x9f9c638 prog=1801807216 vers=1 proc=2
  53. 2013-05-07 16:27:46.741+000016651: debug : virKeepAliveCheckMessage:433 : Got keepalive response from client 0x9f9c638
  54. 2013-05-07 16:27:46.741+000016651: debug : virEventPollUpdateTimeout:259 : EVENT_POLL_UPDATE_TIMEOUT: timer=6 frequency=5000
  55. 2013-05-07 16:27:46.741+000016651: debug : virEventPollInterruptLocked:702 : Skip interrupt, 1 -1231796416
  56. 2013-05-07 16:27:46.741+000016651: debug : virNetMessageFree:75 : msg=0x9faf1e8 nfds=0 cb=(nil)
  57. 2013-05-07 16:27:46.741+000016651: debug : virNetMessageNew:48 : msg=0x9faf1e8 tracked=1
  58. 2013-05-07 16:27:46.741+000016651: debug : virNetServerClientCalculateHandleMode:137 : tls=(nil) hs=-1, rx=0x9faf1e8 tx=(nil)
  59. 2013-05-07 16:27:46.741+000016651: debug : virNetServerClientCalculateHandleMode:167 : mode=1
  60. 2013-05-07 16:27:46.741+000016651: debug : virEventPollUpdateHandle:151 : EVENT_POLL_UPDATE_HANDLE: watch=7 events=1
  61. 2013-05-07 16:27:46.741+000016651: debug : virEventPollInterruptLocked:702 : Skip interrupt, 1 -1231796416
  62. 2013-05-07 16:27:46.741+000016651: debug : virEventPollDispatchHandles:474 : i=7 w=8
  63. 2013-05-07 16:27:46.741+000016651: debug : virEventPollCleanupTimeouts:506 : Cleanup 6
  64. 2013-05-07 16:27:46.741+000016651: debug : virEventPollCleanupHandles:554 : Cleanup 8
  65. 2013-05-07 16:27:46.741+000016651: debug : virEventRunDefaultImpl:244 : running default event implementation
  66. 2013-05-07 16:27:46.741+000016651: debug : virEventPollCleanupTimeouts:506 : Cleanup 6
  67. 2013-05-07 16:27:46.741+000016651: debug : virEventPollCleanupHandles:554 : Cleanup 8
  68. 2013-05-07 16:27:46.741+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=0 w=1, f=7 e=1 d=0
  69. 2013-05-07 16:27:46.741+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=1 w=2, f=9 e=1 d=0
  70. 2013-05-07 16:27:46.741+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=2 w=3, f=11 e=1 d=0
  71. 2013-05-07 16:27:46.741+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=3 w=4, f=12 e=1 d=0
  72. 2013-05-07 16:27:46.741+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=4 w=5, f=13 e=1 d=0
  73. 2013-05-07 16:27:46.741+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=5 w=6, f=14 e=1 d=0
  74. 2013-05-07 16:27:46.741+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=6 w=7, f=15 e=1 d=0
  75. 2013-05-07 16:27:46.741+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=7 w=8, f=18 e=25 d=0
  76. 2013-05-07 16:27:46.741+000016651: debug : virEventPollCalculateTimeout:325 : Calculate expiry of 6 timers
  77. 2013-05-07 16:27:46.741+000016651: debug : virEventPollCalculateTimeout:331 : Got a timeout scheduled for 1367944071741
  78. 2013-05-07 16:27:46.741+000016651: debug : virEventPollCalculateTimeout:351 : Timeout at 1367944071741 due in 5000 ms
  79. 2013-05-07 16:27:46.741+000016651: debug : virEventPollRunOnce:619 : EVENT_POLL_RUN: nhandles=8 imeout=5000
  80. 2013-05-07 16:27:51.746+000016651: debug : virEventPollRunOnce:630 : Poll got 0 event(s)
  81. 2013-05-07 16:27:51.746+000016651: debug : virEventPollDispatchTimeouts:415 : Dispatch 6
  82. 2013-05-07 16:27:51.746+000016651: debug : virEventPollDispatchTimeouts:438 : EVENT_POLL_DISPATCH_TIMEOUT: timer=6
  83. 2013-05-07 16:27:51.746+000016651: debug : virKeepAliveTimer:166 : RPC_KEEPALIVE_TIMEOUT: ka=0x9f95908 client=0x9f9c638 countToDeath=5 idle=5
  84. 2013-05-07 16:27:51.746+000016651: debug : virNetMessageNew:48 : msg=0x9fef230 tracked=0
  85. 2013-05-07 16:27:51.746+000016651: debug : virNetMessageEncodePayloadEmpty:441 : Encode length as 28
  86. 2013-05-07 16:27:51.746+000016651: debug : virKeepAliveSend:119 : Sending keepalive request to client 0x9f9c638
  87. 2013-05-07 16:27:51.746+000016651: debug : virKeepAliveSend:122 : RPC_KEEPALIVE_SEND: ka=0x9f95908 client=0x9f9c638 prog=1801807216 vers=1 proc=1
  88. 2013-05-07 16:27:51.746+000016651: debug : virNetServerClientSendMessage:1106 : msg=0x9fef230 proc=1 len=28 offset=0
  89. 2013-05-07 16:27:51.746+000016651: debug : virNetServerClientSendMessage:1116 : RPC_SERVER_CLIENT_MSG_TX_QUEUE: client=0x9f9c638 len=28 prog=1801807216 vers=1 proc=1 type=2 status=0 serial=0
  90. 2013-05-07 16:27:51.746+000016651: debug : virNetServerClientCalculateHandleMode:137 : tls=(nil) hs=-1, rx=0x9faf1e8 tx=0x9fef230
  91. 2013-05-07 16:27:51.746+000016651: debug : virNetServerClientCalculateHandleMode:167 : mode=3
  92. 2013-05-07 16:27:51.746+000016651: debug : virEventPollUpdateHandle:151 : EVENT_POLL_UPDATE_HANDLE: watch=7 events=3
  93. 2013-05-07 16:27:51.746+000016651: debug : virEventPollInterruptLocked:702 : Skip interrupt, 1 -1231796416
  94. 2013-05-07 16:27:51.746+000016651: debug : virEventPollUpdateTimeout:259 : EVENT_POLL_UPDATE_TIMEOUT: timer=6 frequency=5000
  95. 2013-05-07 16:27:51.746+000016651: debug : virEventPollInterruptLocked:702 : Skip interrupt, 1 -1231796416
  96. 2013-05-07 16:27:51.747+000016651: debug : virEventPollCleanupTimeouts:506 : Cleanup 6
  97. 2013-05-07 16:27:51.747+000016651: debug : virEventPollCleanupHandles:554 : Cleanup 8
  98. 2013-05-07 16:27:51.747+000016651: debug : virEventRunDefaultImpl:244 : running default event implementation
  99. 2013-05-07 16:27:51.747+000016651: debug : virEventPollCleanupTimeouts:506 : Cleanup 6
  100. 2013-05-07 16:27:51.747+000016651: debug : virEventPollCleanupHandles:554 : Cleanup 8
  101. 2013-05-07 16:27:51.747+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=0 w=1, f=7 e=1 d=0
  102. 2013-05-07 16:27:51.747+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=1 w=2, f=9 e=1 d=0
  103. 2013-05-07 16:27:51.747+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=2 w=3, f=11 e=1 d=0
  104. 2013-05-07 16:27:51.747+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=3 w=4, f=12 e=1 d=0
  105. 2013-05-07 16:27:51.747+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=4 w=5, f=13 e=1 d=0
  106. 2013-05-07 16:27:51.747+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=5 w=6, f=14 e=1 d=0
  107. 2013-05-07 16:27:51.747+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=6 w=7, f=15 e=5 d=0
  108. 2013-05-07 16:27:51.747+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=7 w=8, f=18 e=25 d=0
  109. 2013-05-07 16:27:51.747+000016651: debug : virEventPollCalculateTimeout:325 : Calculate expiry of 6 timers
  110. 2013-05-07 16:27:51.747+000016651: debug : virEventPollCalculateTimeout:331 : Got a timeout scheduled for 1367944076746
  111. 2013-05-07 16:27:51.747+000016651: debug : virEventPollCalculateTimeout:351 : Timeout at 1367944076746 due in 4999 ms
  112. 2013-05-07 16:27:51.747+000016651: debug : virEventPollRunOnce:619 : EVENT_POLL_RUN: nhandles=8 imeout=4999
  113. 2013-05-07 16:27:51.747+000016651: debug : virEventPollRunOnce:630 : Poll got 1 event(s)
  114. 2013-05-07 16:27:51.747+000016651: debug : virEventPollDispatchTimeouts:415 : Dispatch 6
  115. 2013-05-07 16:27:51.747+000016651: debug : virEventPollDispatchHandles:460 : Dispatch 8
  116. 2013-05-07 16:27:51.747+000016651: debug : virEventPollDispatchHandles:474 : i=0 w=1
  117. 2013-05-07 16:27:51.747+000016651: debug : virEventPollDispatchHandles:474 : i=1 w=2
  118. 2013-05-07 16:27:51.747+000016651: debug : virEventPollDispatchHandles:474 : i=2 w=3
  119. 2013-05-07 16:27:51.747+000016651: debug : virEventPollDispatchHandles:474 : i=3 w=4
  120. 2013-05-07 16:27:51.747+000016651: debug : virEventPollDispatchHandles:474 : i=4 w=5
  121. 2013-05-07 16:27:51.747+000016651: debug : virEventPollDispatchHandles:474 : i=5 w=6
  122. 2013-05-07 16:27:51.747+000016651: debug : virEventPollDispatchHandles:474 : i=6 w=7
  123. 2013-05-07 16:27:51.747+000016651: debug : virEventPollDispatchHandles:488 : EVENT_POLL_DISPATCH_HANDLE: watch=7 events=2
  124. 2013-05-07 16:27:51.747+000016651: debug : virNetMessageFree:75 : msg=0x9fef230 nfds=0 cb=(nil)
  125. 2013-05-07 16:27:51.747+000016651: debug : virNetServerClientCalculateHandleMode:137 : tls=(nil) hs=-1, rx=0x9faf1e8 tx=(nil)
  126. 2013-05-07 16:27:51.747+000016651: debug : virNetServerClientCalculateHandleMode:167 : mode=1
  127. 2013-05-07 16:27:51.747+000016651: debug : virEventPollUpdateHandle:151 : EVENT_POLL_UPDATE_HANDLE: watch=7 events=1
  128. 2013-05-07 16:27:51.747+000016651: debug : virEventPollInterruptLocked:702 : Skip interrupt, 1 -1231796416
  129. 2013-05-07 16:27:51.747+000016651: debug : virEventPollDispatchHandles:474 : i=7 w=8
  130. 2013-05-07 16:27:51.747+000016651: debug : virEventPollCleanupTimeouts:506 : Cleanup 6
  131. 2013-05-07 16:27:51.747+000016651: debug : virEventPollCleanupHandles:554 : Cleanup 8
  132. 2013-05-07 16:27:51.747+000016651: debug : virEventRunDefaultImpl:244 : running default event implementation
  133. 2013-05-07 16:27:51.747+000016651: debug : virEventPollCleanupTimeouts:506 : Cleanup 6
  134. 2013-05-07 16:27:51.747+000016651: debug : virEventPollCleanupHandles:554 : Cleanup 8
  135. 2013-05-07 16:27:51.747+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=0 w=1, f=7 e=1 d=0
  136. 2013-05-07 16:27:51.747+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=1 w=2, f=9 e=1 d=0
  137. 2013-05-07 16:27:51.747+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=2 w=3, f=11 e=1 d=0
  138. 2013-05-07 16:27:51.747+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=3 w=4, f=12 e=1 d=0
  139. 2013-05-07 16:27:51.747+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=4 w=5, f=13 e=1 d=0
  140. 2013-05-07 16:27:51.747+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=5 w=6, f=14 e=1 d=0
  141. 2013-05-07 16:27:51.747+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=6 w=7, f=15 e=1 d=0
  142. 2013-05-07 16:27:51.747+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=7 w=8, f=18 e=25 d=0
  143. 2013-05-07 16:27:51.747+000016651: debug : virEventPollCalculateTimeout:325 : Calculate expiry of 6 timers
  144. 2013-05-07 16:27:51.747+000016651: debug : virEventPollCalculateTimeout:331 : Got a timeout scheduled for 1367944076746
  145. 2013-05-07 16:27:51.747+000016651: debug : virEventPollCalculateTimeout:351 : Timeout at 1367944076746 due in 4999 ms
  146. 2013-05-07 16:27:51.747+000016651: debug : virEventPollRunOnce:619 : EVENT_POLL_RUN: nhandles=8 imeout=4999
  147. 2013-05-07 16:27:51.780+000016651: debug : virEventPollRunOnce:630 : Poll got 1 event(s)
  148. 2013-05-07 16:27:51.780+000016651: debug : virEventPollDispatchTimeouts:415 : Dispatch 6
  149. 2013-05-07 16:27:51.780+000016651: debug : virEventPollDispatchHandles:460 : Dispatch 8
  150. 2013-05-07 16:27:51.780+000016651: debug : virEventPollDispatchHandles:474 : i=0 w=1
  151. 2013-05-07 16:27:51.780+000016651: debug : virEventPollDispatchHandles:474 : i=1 w=2
  152. 2013-05-07 16:27:51.780+000016651: debug : virEventPollDispatchHandles:474 : i=2 w=3
  153. 2013-05-07 16:27:51.780+000016651: debug : virEventPollDispatchHandles:474 : i=3 w=4
  154. 2013-05-07 16:27:51.780+000016651: debug : virEventPollDispatchHandles:474 : i=4 w=5
  155. 2013-05-07 16:27:51.780+000016651: debug : virEventPollDispatchHandles:474 : i=5 w=6
  156. 2013-05-07 16:27:51.780+000016651: debug : virEventPollDispatchHandles:474 : i=6 w=7
  157. 2013-05-07 16:27:51.780+000016651: debug : virEventPollDispatchHandles:488 : EVENT_POLL_DISPATCH_HANDLE: watch=7 events=1
  158. 2013-05-07 16:27:51.780+000016651: debug : virNetMessageDecodeLength:149 : Got length, now need 28 total (24 more)
  159. 2013-05-07 16:27:51.780+000016651: debug : virNetServerClientCalculateHandleMode:137 : tls=(nil) hs=-1, rx=0x9faf1e8 tx=(nil)
  160. 2013-05-07 16:27:51.780+000016651: debug : virNetServerClientCalculateHandleMode:167 : mode=1
  161. 2013-05-07 16:27:51.780+000016651: debug : virEventPollUpdateHandle:151 : EVENT_POLL_UPDATE_HANDLE: watch=7 events=1
  162. 2013-05-07 16:27:51.780+000016651: debug : virEventPollInterruptLocked:702 : Skip interrupt, 1 -1231796416
  163. 2013-05-07 16:27:51.780+000016651: debug : virNetServerClientDispatchRead:886 : RPC_SERVER_CLIENT_MSG_RX: client=0x9f9c638 len=28 prog=1801807216 vers=1 proc=2 type=2 status=0 serial=0
  164. 2013-05-07 16:27:51.780+000016651: debug : virKeepAliveCheckMessage:408 : ka=0x9f95908, client=0x9f9c638, msg=0x9faf1e8
  165. 2013-05-07 16:27:51.780+000016651: debug : virKeepAliveCheckMessage:424 : RPC_KEEPALIVE_RECEIVED: ka=0x9f95908 client=0x9f9c638 prog=1801807216 vers=1 proc=2
  166. 2013-05-07 16:27:51.780+000016651: debug : virKeepAliveCheckMessage:433 : Got keepalive response from client 0x9f9c638
  167. 2013-05-07 16:27:51.780+000016651: debug : virEventPollUpdateTimeout:259 : EVENT_POLL_UPDATE_TIMEOUT: timer=6 frequency=5000
  168. 2013-05-07 16:27:51.780+000016651: debug : virEventPollInterruptLocked:702 : Skip interrupt, 1 -1231796416
  169. 2013-05-07 16:27:51.780+000016651: debug : virNetMessageFree:75 : msg=0x9faf1e8 nfds=0 cb=(nil)
  170. 2013-05-07 16:27:51.781+000016651: debug : virNetMessageNew:48 : msg=0x9faf1e8 tracked=1
  171. 2013-05-07 16:27:51.781+000016651: debug : virNetServerClientCalculateHandleMode:137 : tls=(nil) hs=-1, rx=0x9faf1e8 tx=(nil)
  172. 2013-05-07 16:27:51.781+000016651: debug : virNetServerClientCalculateHandleMode:167 : mode=1
  173. 2013-05-07 16:27:51.781+000016651: debug : virEventPollUpdateHandle:151 : EVENT_POLL_UPDATE_HANDLE: watch=7 events=1
  174. 2013-05-07 16:27:51.781+000016651: debug : virEventPollInterruptLocked:702 : Skip interrupt, 1 -1231796416
  175. 2013-05-07 16:27:51.781+000016651: debug : virEventPollDispatchHandles:474 : i=7 w=8
  176. 2013-05-07 16:27:51.781+000016651: debug : virEventPollCleanupTimeouts:506 : Cleanup 6
  177. 2013-05-07 16:27:51.781+000016651: debug : virEventPollCleanupHandles:554 : Cleanup 8
  178. 2013-05-07 16:27:51.781+000016651: debug : virEventRunDefaultImpl:244 : running default event implementation
  179. 2013-05-07 16:27:51.781+000016651: debug : virEventPollCleanupTimeouts:506 : Cleanup 6
  180. 2013-05-07 16:27:51.781+000016651: debug : virEventPollCleanupHandles:554 : Cleanup 8
  181. 2013-05-07 16:27:51.781+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=0 w=1, f=7 e=1 d=0
  182. 2013-05-07 16:27:51.781+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=1 w=2, f=9 e=1 d=0
  183. 2013-05-07 16:27:51.781+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=2 w=3, f=11 e=1 d=0
  184. 2013-05-07 16:27:51.781+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=3 w=4, f=12 e=1 d=0
  185. 2013-05-07 16:27:51.781+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=4 w=5, f=13 e=1 d=0
  186. 2013-05-07 16:27:51.781+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=5 w=6, f=14 e=1 d=0
  187. 2013-05-07 16:27:51.781+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=6 w=7, f=15 e=1 d=0
  188. 2013-05-07 16:27:51.781+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=7 w=8, f=18 e=25 d=0
  189. 2013-05-07 16:27:51.781+000016651: debug : virEventPollCalculateTimeout:325 : Calculate expiry of 6 timers
  190. 2013-05-07 16:27:51.781+000016651: debug : virEventPollCalculateTimeout:331 : Got a timeout scheduled for 1367944076780
  191. 2013-05-07 16:27:51.781+000016651: debug : virEventPollCalculateTimeout:351 : Timeout at 1367944076780 due in 4999 ms
  192. 2013-05-07 16:27:51.781+000016651: debug : virEventPollRunOnce:619 : EVENT_POLL_RUN: nhandles=8 imeout=4999
  193. 2013-05-07 16:27:56.783+000016651: debug : virEventPollRunOnce:630 : Poll got 0 event(s)
  194. 2013-05-07 16:27:56.783+000016651: debug : virEventPollDispatchTimeouts:415 : Dispatch 6
  195. 2013-05-07 16:27:56.784+000016651: debug : virEventPollDispatchTimeouts:438 : EVENT_POLL_DISPATCH_TIMEOUT: timer=6
  196. 2013-05-07 16:27:56.784+000016651: debug : virKeepAliveTimer:166 : RPC_KEEPALIVE_TIMEOUT: ka=0x9f95908 client=0x9f9c638 countToDeath=5 idle=5
  197. 2013-05-07 16:27:56.784+000016651: debug : virNetMessageNew:48 : msg=0x9fef230 tracked=0
  198. 2013-05-07 16:27:56.784+000016651: debug : virNetMessageEncodePayloadEmpty:441 : Encode length as 28
  199. 2013-05-07 16:27:56.784+000016651: debug : virKeepAliveSend:119 : Sending keepalive request to client 0x9f9c638
  200. 2013-05-07 16:27:56.784+000016651: debug : virKeepAliveSend:122 : RPC_KEEPALIVE_SEND: ka=0x9f95908 client=0x9f9c638 prog=1801807216 vers=1 proc=1
  201. 2013-05-07 16:27:56.784+000016651: debug : virNetServerClientSendMessage:1106 : msg=0x9fef230 proc=1 len=28 offset=0
  202. 2013-05-07 16:27:56.784+000016651: debug : virNetServerClientSendMessage:1116 : RPC_SERVER_CLIENT_MSG_TX_QUEUE: client=0x9f9c638 len=28 prog=1801807216 vers=1 proc=1 type=2 status=0 serial=0
  203. 2013-05-07 16:27:56.784+000016651: debug : virNetServerClientCalculateHandleMode:137 : tls=(nil) hs=-1, rx=0x9faf1e8 tx=0x9fef230
  204. 2013-05-07 16:27:56.784+000016651: debug : virNetServerClientCalculateHandleMode:167 : mode=3
  205. 2013-05-07 16:27:56.784+000016651: debug : virEventPollUpdateHandle:151 : EVENT_POLL_UPDATE_HANDLE: watch=7 events=3
  206. 2013-05-07 16:27:56.784+000016651: debug : virEventPollInterruptLocked:702 : Skip interrupt, 1 -1231796416
  207. 2013-05-07 16:27:56.784+000016651: debug : virEventPollUpdateTimeout:259 : EVENT_POLL_UPDATE_TIMEOUT: timer=6 frequency=5000
  208. 2013-05-07 16:27:56.784+000016651: debug : virEventPollInterruptLocked:702 : Skip interrupt, 1 -1231796416
  209. 2013-05-07 16:27:56.784+000016651: debug : virEventPollCleanupTimeouts:506 : Cleanup 6
  210. 2013-05-07 16:27:56.784+000016651: debug : virEventPollCleanupHandles:554 : Cleanup 8
  211. 2013-05-07 16:27:56.784+000016651: debug : virEventRunDefaultImpl:244 : running default event implementation
  212. 2013-05-07 16:27:56.784+000016651: debug : virEventPollCleanupTimeouts:506 : Cleanup 6
  213. 2013-05-07 16:27:56.784+000016651: debug : virEventPollCleanupHandles:554 : Cleanup 8
  214. 2013-05-07 16:27:56.784+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=0 w=1, f=7 e=1 d=0
  215. 2013-05-07 16:27:56.784+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=1 w=2, f=9 e=1 d=0
  216. 2013-05-07 16:27:56.784+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=2 w=3, f=11 e=1 d=0
  217. 2013-05-07 16:27:56.784+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=3 w=4, f=12 e=1 d=0
  218. 2013-05-07 16:27:56.784+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=4 w=5, f=13 e=1 d=0
  219. 2013-05-07 16:27:56.784+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=5 w=6, f=14 e=1 d=0
  220. 2013-05-07 16:27:56.784+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=6 w=7, f=15 e=5 d=0
  221. 2013-05-07 16:27:56.784+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=7 w=8, f=18 e=25 d=0
  222. 2013-05-07 16:27:56.784+000016651: debug : virEventPollCalculateTimeout:325 : Calculate expiry of 6 timers
  223. 2013-05-07 16:27:56.784+000016651: debug : virEventPollCalculateTimeout:331 : Got a timeout scheduled for 1367944081784
  224. 2013-05-07 16:27:56.784+000016651: debug : virEventPollCalculateTimeout:351 : Timeout at 1367944081784 due in 5000 ms
  225. 2013-05-07 16:27:56.784+000016651: debug : virEventPollRunOnce:619 : EVENT_POLL_RUN: nhandles=8 imeout=5000
  226. 2013-05-07 16:27:56.784+000016651: debug : virEventPollRunOnce:630 : Poll got 1 event(s)
  227. 2013-05-07 16:27:56.784+000016651: debug : virEventPollDispatchTimeouts:415 : Dispatch 6
  228. 2013-05-07 16:27:56.784+000016651: debug : virEventPollDispatchHandles:460 : Dispatch 8
  229. 2013-05-07 16:27:56.784+000016651: debug : virEventPollDispatchHandles:474 : i=0 w=1
  230. 2013-05-07 16:27:56.784+000016651: debug : virEventPollDispatchHandles:474 : i=1 w=2
  231. 2013-05-07 16:27:56.784+000016651: debug : virEventPollDispatchHandles:474 : i=2 w=3
  232. 2013-05-07 16:27:56.784+000016651: debug : virEventPollDispatchHandles:474 : i=3 w=4
  233. 2013-05-07 16:27:56.784+000016651: debug : virEventPollDispatchHandles:474 : i=4 w=5
  234. 2013-05-07 16:27:56.784+000016651: debug : virEventPollDispatchHandles:474 : i=5 w=6
  235. 2013-05-07 16:27:56.784+000016651: debug : virEventPollDispatchHandles:474 : i=6 w=7
  236. 2013-05-07 16:27:56.784+000016651: debug : virEventPollDispatchHandles:488 : EVENT_POLL_DISPATCH_HANDLE: watch=7 events=2
  237. 2013-05-07 16:27:56.784+000016651: debug : virNetMessageFree:75 : msg=0x9fef230 nfds=0 cb=(nil)
  238. 2013-05-07 16:27:56.784+000016651: debug : virNetServerClientCalculateHandleMode:137 : tls=(nil) hs=-1, rx=0x9faf1e8 tx=(nil)
  239. 2013-05-07 16:27:56.784+000016651: debug : virNetServerClientCalculateHandleMode:167 : mode=1
  240. 2013-05-07 16:27:56.784+000016651: debug : virEventPollUpdateHandle:151 : EVENT_POLL_UPDATE_HANDLE: watch=7 events=1
  241. 2013-05-07 16:27:56.784+000016651: debug : virEventPollInterruptLocked:702 : Skip interrupt, 1 -1231796416
  242. 2013-05-07 16:27:56.784+000016651: debug : virEventPollDispatchHandles:474 : i=7 w=8
  243. 2013-05-07 16:27:56.784+000016651: debug : virEventPollCleanupTimeouts:506 : Cleanup 6
  244. 2013-05-07 16:27:56.784+000016651: debug : virEventPollCleanupHandles:554 : Cleanup 8
  245. 2013-05-07 16:27:56.784+000016651: debug : virEventRunDefaultImpl:244 : running default event implementation
  246. 2013-05-07 16:27:56.784+000016651: debug : virEventPollCleanupTimeouts:506 : Cleanup 6
  247. 2013-05-07 16:27:56.784+000016651: debug : virEventPollCleanupHandles:554 : Cleanup 8
  248. 2013-05-07 16:27:56.784+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=0 w=1, f=7 e=1 d=0
  249. 2013-05-07 16:27:56.784+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=1 w=2, f=9 e=1 d=0
  250. 2013-05-07 16:27:56.784+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=2 w=3, f=11 e=1 d=0
  251. 2013-05-07 16:27:56.784+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=3 w=4, f=12 e=1 d=0
  252. 2013-05-07 16:27:56.784+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=4 w=5, f=13 e=1 d=0
  253. 2013-05-07 16:27:56.784+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=5 w=6, f=14 e=1 d=0
  254. 2013-05-07 16:27:56.784+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=6 w=7, f=15 e=1 d=0
  255. 2013-05-07 16:27:56.784+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=7 w=8, f=18 e=25 d=0
  256. 2013-05-07 16:27:56.784+000016651: debug : virEventPollCalculateTimeout:325 : Calculate expiry of 6 timers
  257. 2013-05-07 16:27:56.784+000016651: debug : virEventPollCalculateTimeout:331 : Got a timeout scheduled for 1367944081784
  258. 2013-05-07 16:27:56.784+000016651: debug : virEventPollCalculateTimeout:351 : Timeout at 1367944081784 due in 5000 ms
  259. 2013-05-07 16:27:56.784+000016651: debug : virEventPollRunOnce:619 : EVENT_POLL_RUN: nhandles=8 imeout=5000
  260. 2013-05-07 16:27:56.816+000016651: debug : virEventPollRunOnce:630 : Poll got 1 event(s)
  261. 2013-05-07 16:27:56.816+000016651: debug : virEventPollDispatchTimeouts:415 : Dispatch 6
  262. 2013-05-07 16:27:56.816+000016651: debug : virEventPollDispatchHandles:460 : Dispatch 8
  263. 2013-05-07 16:27:56.816+000016651: debug : virEventPollDispatchHandles:474 : i=0 w=1
  264. 2013-05-07 16:27:56.816+000016651: debug : virEventPollDispatchHandles:474 : i=1 w=2
  265. 2013-05-07 16:27:56.816+000016651: debug : virEventPollDispatchHandles:474 : i=2 w=3
  266. 2013-05-07 16:27:56.816+000016651: debug : virEventPollDispatchHandles:474 : i=3 w=4
  267. 2013-05-07 16:27:56.816+000016651: debug : virEventPollDispatchHandles:474 : i=4 w=5
  268. 2013-05-07 16:27:56.816+000016651: debug : virEventPollDispatchHandles:474 : i=5 w=6
  269. 2013-05-07 16:27:56.816+000016651: debug : virEventPollDispatchHandles:474 : i=6 w=7
  270. 2013-05-07 16:27:56.816+000016651: debug : virEventPollDispatchHandles:488 : EVENT_POLL_DISPATCH_HANDLE: watch=7 events=1
  271. 2013-05-07 16:27:56.816+000016651: debug : virNetMessageDecodeLength:149 : Got length, now need 28 total (24 more)
  272. 2013-05-07 16:27:56.816+000016651: debug : virNetServerClientCalculateHandleMode:137 : tls=(nil) hs=-1, rx=0x9faf1e8 tx=(nil)
  273. 2013-05-07 16:27:56.816+000016651: debug : virNetServerClientCalculateHandleMode:167 : mode=1
  274. 2013-05-07 16:27:56.816+000016651: debug : virEventPollUpdateHandle:151 : EVENT_POLL_UPDATE_HANDLE: watch=7 events=1
  275. 2013-05-07 16:27:56.816+000016651: debug : virEventPollInterruptLocked:702 : Skip interrupt, 1 -1231796416
  276. 2013-05-07 16:27:56.816+000016651: debug : virNetServerClientDispatchRead:886 : RPC_SERVER_CLIENT_MSG_RX: client=0x9f9c638 len=28 prog=1801807216 vers=1 proc=2 type=2 status=0 serial=0
  277. 2013-05-07 16:27:56.816+000016651: debug : virKeepAliveCheckMessage:408 : ka=0x9f95908, client=0x9f9c638, msg=0x9faf1e8
  278. 2013-05-07 16:27:56.816+000016651: debug : virKeepAliveCheckMessage:424 : RPC_KEEPALIVE_RECEIVED: ka=0x9f95908 client=0x9f9c638 prog=1801807216 vers=1 proc=2
  279. 2013-05-07 16:27:56.816+000016651: debug : virKeepAliveCheckMessage:433 : Got keepalive response from client 0x9f9c638
  280. 2013-05-07 16:27:56.816+000016651: debug : virEventPollUpdateTimeout:259 : EVENT_POLL_UPDATE_TIMEOUT: timer=6 frequency=5000
  281. 2013-05-07 16:27:56.816+000016651: debug : virEventPollInterruptLocked:702 : Skip interrupt, 1 -1231796416
  282. 2013-05-07 16:27:56.816+000016651: debug : virNetMessageFree:75 : msg=0x9faf1e8 nfds=0 cb=(nil)
  283. 2013-05-07 16:27:56.817+000016651: debug : virNetMessageNew:48 : msg=0x9faf1e8 tracked=1
  284. 2013-05-07 16:27:56.817+000016651: debug : virNetServerClientCalculateHandleMode:137 : tls=(nil) hs=-1, rx=0x9faf1e8 tx=(nil)
  285. 2013-05-07 16:27:56.817+000016651: debug : virNetServerClientCalculateHandleMode:167 : mode=1
  286. 2013-05-07 16:27:56.817+000016651: debug : virEventPollUpdateHandle:151 : EVENT_POLL_UPDATE_HANDLE: watch=7 events=1
  287. 2013-05-07 16:27:56.817+000016651: debug : virEventPollInterruptLocked:702 : Skip interrupt, 1 -1231796416
  288. 2013-05-07 16:27:56.817+000016651: debug : virEventPollDispatchHandles:474 : i=7 w=8
  289. 2013-05-07 16:27:56.817+000016651: debug : virEventPollCleanupTimeouts:506 : Cleanup 6
  290. 2013-05-07 16:27:56.817+000016651: debug : virEventPollCleanupHandles:554 : Cleanup 8
  291. 2013-05-07 16:27:56.817+000016651: debug : virEventRunDefaultImpl:244 : running default event implementation
  292. 2013-05-07 16:27:56.817+000016651: debug : virEventPollCleanupTimeouts:506 : Cleanup 6
  293. 2013-05-07 16:27:56.817+000016651: debug : virEventPollCleanupHandles:554 : Cleanup 8
  294. 2013-05-07 16:27:56.817+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=0 w=1, f=7 e=1 d=0
  295. 2013-05-07 16:27:56.817+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=1 w=2, f=9 e=1 d=0
  296. 2013-05-07 16:27:56.817+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=2 w=3, f=11 e=1 d=0
  297. 2013-05-07 16:27:56.817+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=3 w=4, f=12 e=1 d=0
  298. 2013-05-07 16:27:56.817+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=4 w=5, f=13 e=1 d=0
  299. 2013-05-07 16:27:56.817+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=5 w=6, f=14 e=1 d=0
  300. 2013-05-07 16:27:56.817+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=6 w=7, f=15 e=1 d=0
  301. 2013-05-07 16:27:56.817+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=7 w=8, f=18 e=25 d=0
  302. 2013-05-07 16:27:56.817+000016651: debug : virEventPollCalculateTimeout:325 : Calculate expiry of 6 timers
  303. 2013-05-07 16:27:56.817+000016651: debug : virEventPollCalculateTimeout:331 : Got a timeout scheduled for 1367944081816
  304. 2013-05-07 16:27:56.817+000016651: debug : virEventPollCalculateTimeout:351 : Timeout at 1367944081816 due in 4999 ms
  305. 2013-05-07 16:27:56.817+000016651: debug : virEventPollRunOnce:619 : EVENT_POLL_RUN: nhandles=8 imeout=4999
  306. 2013-05-07 16:27:59.649+000016651: debug : virEventPollRunOnce:630 : Poll got 1 event(s)
  307. 2013-05-07 16:27:59.649+000016651: debug : virEventPollDispatchTimeouts:415 : Dispatch 6
  308. 2013-05-07 16:27:59.649+000016651: debug : virEventPollDispatchHandles:460 : Dispatch 8
  309. 2013-05-07 16:27:59.649+000016651: debug : virEventPollDispatchHandles:474 : i=0 w=1
  310. 2013-05-07 16:27:59.649+000016651: debug : virEventPollDispatchHandles:474 : i=1 w=2
  311. 2013-05-07 16:27:59.649+000016651: debug : virEventPollDispatchHandles:474 : i=2 w=3
  312. 2013-05-07 16:27:59.649+000016651: debug : virEventPollDispatchHandles:474 : i=3 w=4
  313. 2013-05-07 16:27:59.649+000016651: debug : virEventPollDispatchHandles:474 : i=4 w=5
  314. 2013-05-07 16:27:59.649+000016651: debug : virEventPollDispatchHandles:488 : EVENT_POLL_DISPATCH_HANDLE: watch=5 events=1
  315. 2013-05-07 16:27:59.649+000016651: debug : udevEventHandleCallback:1467 : udev action: 'remove'
  316. 2013-05-07 16:27:59.649+000016651: debug : udevRemoveOneDevice:1218 : Failed to find device to remove that has udev name '/sys/devices/virtual/net/vnet0/queues/rx-0'
  317. 2013-05-07 16:27:59.649+000016651: debug : virEventPollDispatchHandles:474 : i=5 w=6
  318. 2013-05-07 16:27:59.649+000016651: debug : virEventPollDispatchHandles:474 : i=6 w=7
  319. 2013-05-07 16:27:59.649+000016651: debug : virEventPollDispatchHandles:474 : i=7 w=8
  320. 2013-05-07 16:27:59.649+000016651: debug : virEventPollCleanupTimeouts:506 : Cleanup 6
  321. 2013-05-07 16:27:59.649+000016651: debug : virEventPollCleanupHandles:554 : Cleanup 8
  322. 2013-05-07 16:27:59.649+000016651: debug : virEventRunDefaultImpl:244 : running default event implementation
  323. 2013-05-07 16:27:59.649+000016651: debug : virEventPollCleanupTimeouts:506 : Cleanup 6
  324. 2013-05-07 16:27:59.649+000016651: debug : virEventPollCleanupHandles:554 : Cleanup 8
  325. 2013-05-07 16:27:59.649+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=0 w=1, f=7 e=1 d=0
  326. 2013-05-07 16:27:59.649+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=1 w=2, f=9 e=1 d=0
  327. 2013-05-07 16:27:59.649+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=2 w=3, f=11 e=1 d=0
  328. 2013-05-07 16:27:59.649+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=3 w=4, f=12 e=1 d=0
  329. 2013-05-07 16:27:59.649+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=4 w=5, f=13 e=1 d=0
  330. 2013-05-07 16:27:59.649+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=5 w=6, f=14 e=1 d=0
  331. 2013-05-07 16:27:59.649+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=6 w=7, f=15 e=1 d=0
  332. 2013-05-07 16:27:59.649+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=7 w=8, f=18 e=25 d=0
  333. 2013-05-07 16:27:59.649+000016651: debug : virEventPollCalculateTimeout:325 : Calculate expiry of 6 timers
  334. 2013-05-07 16:27:59.649+000016651: debug : virEventPollCalculateTimeout:331 : Got a timeout scheduled for 1367944081816
  335. 2013-05-07 16:27:59.649+000016651: debug : virEventPollCalculateTimeout:351 : Timeout at 1367944081816 due in 2167 ms
  336. 2013-05-07 16:27:59.649+000016651: debug : virEventPollRunOnce:619 : EVENT_POLL_RUN: nhandles=8 imeout=2167
  337. 2013-05-07 16:27:59.649+000016651: debug : virEventPollRunOnce:630 : Poll got 1 event(s)
  338. 2013-05-07 16:27:59.649+000016651: debug : virEventPollDispatchTimeouts:415 : Dispatch 6
  339. 2013-05-07 16:27:59.649+000016651: debug : virEventPollDispatchHandles:460 : Dispatch 8
  340. 2013-05-07 16:27:59.649+000016651: debug : virEventPollDispatchHandles:474 : i=0 w=1
  341. 2013-05-07 16:27:59.649+000016651: debug : virEventPollDispatchHandles:474 : i=1 w=2
  342. 2013-05-07 16:27:59.649+000016651: debug : virEventPollDispatchHandles:474 : i=2 w=3
  343. 2013-05-07 16:27:59.649+000016651: debug : virEventPollDispatchHandles:474 : i=3 w=4
  344. 2013-05-07 16:27:59.649+000016651: debug : virEventPollDispatchHandles:474 : i=4 w=5
  345. 2013-05-07 16:27:59.649+000016651: debug : virEventPollDispatchHandles:488 : EVENT_POLL_DISPATCH_HANDLE: watch=5 events=1
  346. 2013-05-07 16:27:59.649+000016651: debug : udevEventHandleCallback:1467 : udev action: 'remove'
  347. 2013-05-07 16:27:59.649+000016651: debug : udevRemoveOneDevice:1218 : Failed to find device to remove that has udev name '/sys/devices/virtual/net/vnet0/queues/tx-0'
  348. 2013-05-07 16:27:59.649+000016651: debug : virEventPollDispatchHandles:474 : i=5 w=6
  349. 2013-05-07 16:27:59.649+000016651: debug : virEventPollDispatchHandles:474 : i=6 w=7
  350. 2013-05-07 16:27:59.649+000016651: debug : virEventPollDispatchHandles:474 : i=7 w=8
  351. 2013-05-07 16:27:59.649+000016651: debug : virEventPollCleanupTimeouts:506 : Cleanup 6
  352. 2013-05-07 16:27:59.649+000016651: debug : virEventPollCleanupHandles:554 : Cleanup 8
  353. 2013-05-07 16:27:59.649+000016651: debug : virEventRunDefaultImpl:244 : running default event implementation
  354. 2013-05-07 16:27:59.649+000016651: debug : virEventPollCleanupTimeouts:506 : Cleanup 6
  355. 2013-05-07 16:27:59.649+000016651: debug : virEventPollCleanupHandles:554 : Cleanup 8
  356. 2013-05-07 16:27:59.649+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=0 w=1, f=7 e=1 d=0
  357. 2013-05-07 16:27:59.649+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=1 w=2, f=9 e=1 d=0
  358. 2013-05-07 16:27:59.649+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=2 w=3, f=11 e=1 d=0
  359. 2013-05-07 16:27:59.649+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=3 w=4, f=12 e=1 d=0
  360. 2013-05-07 16:27:59.649+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=4 w=5, f=13 e=1 d=0
  361. 2013-05-07 16:27:59.649+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=5 w=6, f=14 e=1 d=0
  362. 2013-05-07 16:27:59.649+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=6 w=7, f=15 e=1 d=0
  363. 2013-05-07 16:27:59.650+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=7 w=8, f=18 e=25 d=0
  364. 2013-05-07 16:27:59.650+000016651: debug : virEventPollCalculateTimeout:325 : Calculate expiry of 6 timers
  365. 2013-05-07 16:27:59.650+000016651: debug : virEventPollCalculateTimeout:331 : Got a timeout scheduled for 1367944081816
  366. 2013-05-07 16:27:59.650+000016651: debug : virEventPollCalculateTimeout:351 : Timeout at 1367944081816 due in 2166 ms
  367. 2013-05-07 16:27:59.650+000016651: debug : virEventPollRunOnce:619 : EVENT_POLL_RUN: nhandles=8 imeout=2166
  368. 2013-05-07 16:27:59.650+000016651: debug : virEventPollRunOnce:630 : Poll got 1 event(s)
  369. 2013-05-07 16:27:59.650+000016651: debug : virEventPollDispatchTimeouts:415 : Dispatch 6
  370. 2013-05-07 16:27:59.650+000016651: debug : virEventPollDispatchHandles:460 : Dispatch 8
  371. 2013-05-07 16:27:59.650+000016651: debug : virEventPollDispatchHandles:474 : i=0 w=1
  372. 2013-05-07 16:27:59.650+000016651: debug : virEventPollDispatchHandles:474 : i=1 w=2
  373. 2013-05-07 16:27:59.650+000016651: debug : virEventPollDispatchHandles:474 : i=2 w=3
  374. 2013-05-07 16:27:59.650+000016651: debug : virEventPollDispatchHandles:474 : i=3 w=4
  375. 2013-05-07 16:27:59.650+000016651: debug : virEventPollDispatchHandles:474 : i=4 w=5
  376. 2013-05-07 16:27:59.650+000016651: debug : virEventPollDispatchHandles:488 : EVENT_POLL_DISPATCH_HANDLE: watch=5 events=1
  377. 2013-05-07 16:27:59.650+000016651: debug : udevEventHandleCallback:1467 : udev action: 'remove'
  378. 2013-05-07 16:27:59.650+000016651: debug : udevRemoveOneDevice:1214 : Removing device 'net_vnet0_fe_54_00_93_8b_03' with sysfs path '/sys/devices/virtual/net/vnet0'
  379. 2013-05-07 16:27:59.650+000016651: debug : virEventPollDispatchHandles:474 : i=5 w=6
  380. 2013-05-07 16:27:59.650+000016651: debug : virEventPollDispatchHandles:474 : i=6 w=7
  381. 2013-05-07 16:27:59.650+000016651: debug : virEventPollDispatchHandles:474 : i=7 w=8
  382. 2013-05-07 16:27:59.650+000016651: debug : virEventPollCleanupTimeouts:506 : Cleanup 6
  383. 2013-05-07 16:27:59.650+000016651: debug : virEventPollCleanupHandles:554 : Cleanup 8
  384. 2013-05-07 16:27:59.650+000016651: debug : virEventRunDefaultImpl:244 : running default event implementation
  385. 2013-05-07 16:27:59.650+000016651: debug : virEventPollCleanupTimeouts:506 : Cleanup 6
  386. 2013-05-07 16:27:59.650+000016651: debug : virEventPollCleanupHandles:554 : Cleanup 8
  387. 2013-05-07 16:27:59.650+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=0 w=1, f=7 e=1 d=0
  388. 2013-05-07 16:27:59.650+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=1 w=2, f=9 e=1 d=0
  389. 2013-05-07 16:27:59.650+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=2 w=3, f=11 e=1 d=0
  390. 2013-05-07 16:27:59.650+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=3 w=4, f=12 e=1 d=0
  391. 2013-05-07 16:27:59.650+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=4 w=5, f=13 e=1 d=0
  392. 2013-05-07 16:27:59.650+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=5 w=6, f=14 e=1 d=0
  393. 2013-05-07 16:27:59.650+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=6 w=7, f=15 e=1 d=0
  394. 2013-05-07 16:27:59.650+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=7 w=8, f=18 e=25 d=0
  395. 2013-05-07 16:27:59.650+000016651: debug : virEventPollCalculateTimeout:325 : Calculate expiry of 6 timers
  396. 2013-05-07 16:27:59.650+000016651: debug : virEventPollCalculateTimeout:331 : Got a timeout scheduled for 1367944081816
  397. 2013-05-07 16:27:59.650+000016651: debug : virEventPollCalculateTimeout:351 : Timeout at 1367944081816 due in 2166 ms
  398. 2013-05-07 16:27:59.650+000016651: debug : virEventPollRunOnce:619 : EVENT_POLL_RUN: nhandles=8 imeout=2166
  399. 2013-05-07 16:27:59.664+000016651: debug : virEventPollRunOnce:630 : Poll got 1 event(s)
  400. 2013-05-07 16:27:59.664+000016651: debug : virEventPollDispatchTimeouts:415 : Dispatch 6
  401. 2013-05-07 16:27:59.664+000016651: debug : virEventPollDispatchHandles:460 : Dispatch 8
  402. 2013-05-07 16:27:59.664+000016651: debug : virEventPollDispatchHandles:474 : i=0 w=1
  403. 2013-05-07 16:27:59.664+000016651: debug : virEventPollDispatchHandles:474 : i=1 w=2
  404. 2013-05-07 16:27:59.664+000016651: debug : virEventPollDispatchHandles:474 : i=2 w=3
  405. 2013-05-07 16:27:59.664+000016651: debug : virEventPollDispatchHandles:474 : i=3 w=4
  406. 2013-05-07 16:27:59.664+000016651: debug : virEventPollDispatchHandles:474 : i=4 w=5
  407. 2013-05-07 16:27:59.664+000016651: debug : virEventPollDispatchHandles:488 : EVENT_POLL_DISPATCH_HANDLE: watch=5 events=1
  408. 2013-05-07 16:27:59.664+000016651: debug : udevEventHandleCallback:1467 : udev action: 'remove'
  409. 2013-05-07 16:27:59.664+000016651: debug : udevRemoveOneDevice:1218 : Failed to find device to remove that has udev name '/sys/devices/virtual/net/vnet1/queues/rx-0'
  410. 2013-05-07 16:27:59.664+000016651: debug : virEventPollDispatchHandles:474 : i=5 w=6
  411. 2013-05-07 16:27:59.664+000016651: debug : virEventPollDispatchHandles:474 : i=6 w=7
  412. 2013-05-07 16:27:59.664+000016651: debug : virEventPollDispatchHandles:474 : i=7 w=8
  413. 2013-05-07 16:27:59.664+000016651: debug : virEventPollCleanupTimeouts:506 : Cleanup 6
  414. 2013-05-07 16:27:59.664+000016651: debug : virEventPollCleanupHandles:554 : Cleanup 8
  415. 2013-05-07 16:27:59.664+000016651: debug : virEventRunDefaultImpl:244 : running default event implementation
  416. 2013-05-07 16:27:59.664+000016651: debug : virEventPollCleanupTimeouts:506 : Cleanup 6
  417. 2013-05-07 16:27:59.664+000016651: debug : virEventPollCleanupHandles:554 : Cleanup 8
  418. 2013-05-07 16:27:59.664+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=0 w=1, f=7 e=1 d=0
  419. 2013-05-07 16:27:59.664+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=1 w=2, f=9 e=1 d=0
  420. 2013-05-07 16:27:59.664+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=2 w=3, f=11 e=1 d=0
  421. 2013-05-07 16:27:59.664+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=3 w=4, f=12 e=1 d=0
  422. 2013-05-07 16:27:59.664+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=4 w=5, f=13 e=1 d=0
  423. 2013-05-07 16:27:59.664+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=5 w=6, f=14 e=1 d=0
  424. 2013-05-07 16:27:59.664+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=6 w=7, f=15 e=1 d=0
  425. 2013-05-07 16:27:59.664+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=7 w=8, f=18 e=25 d=0
  426. 2013-05-07 16:27:59.664+000016651: debug : virEventPollCalculateTimeout:325 : Calculate expiry of 6 timers
  427. 2013-05-07 16:27:59.664+000016651: debug : virEventPollCalculateTimeout:331 : Got a timeout scheduled for 1367944081816
  428. 2013-05-07 16:27:59.664+000016651: debug : virEventPollCalculateTimeout:351 : Timeout at 1367944081816 due in 2152 ms
  429. 2013-05-07 16:27:59.664+000016651: debug : virEventPollRunOnce:619 : EVENT_POLL_RUN: nhandles=8 imeout=2152
  430. 2013-05-07 16:27:59.664+000016651: debug : virEventPollRunOnce:630 : Poll got 1 event(s)
  431. 2013-05-07 16:27:59.664+000016651: debug : virEventPollDispatchTimeouts:415 : Dispatch 6
  432. 2013-05-07 16:27:59.664+000016651: debug : virEventPollDispatchHandles:460 : Dispatch 8
  433. 2013-05-07 16:27:59.664+000016651: debug : virEventPollDispatchHandles:474 : i=0 w=1
  434. 2013-05-07 16:27:59.664+000016651: debug : virEventPollDispatchHandles:474 : i=1 w=2
  435. 2013-05-07 16:27:59.664+000016651: debug : virEventPollDispatchHandles:474 : i=2 w=3
  436. 2013-05-07 16:27:59.664+000016651: debug : virEventPollDispatchHandles:474 : i=3 w=4
  437. 2013-05-07 16:27:59.664+000016651: debug : virEventPollDispatchHandles:474 : i=4 w=5
  438. 2013-05-07 16:27:59.664+000016651: debug : virEventPollDispatchHandles:488 : EVENT_POLL_DISPATCH_HANDLE: watch=5 events=1
  439. 2013-05-07 16:27:59.664+000016651: debug : udevEventHandleCallback:1467 : udev action: 'remove'
  440. 2013-05-07 16:27:59.664+000016651: debug : udevRemoveOneDevice:1218 : Failed to find device to remove that has udev name '/sys/devices/virtual/net/vnet1/queues/tx-0'
  441. 2013-05-07 16:27:59.664+000016651: debug : virEventPollDispatchHandles:474 : i=5 w=6
  442. 2013-05-07 16:27:59.664+000016651: debug : virEventPollDispatchHandles:474 : i=6 w=7
  443. 2013-05-07 16:27:59.664+000016651: debug : virEventPollDispatchHandles:474 : i=7 w=8
  444. 2013-05-07 16:27:59.664+000016651: debug : virEventPollCleanupTimeouts:506 : Cleanup 6
  445. 2013-05-07 16:27:59.664+000016651: debug : virEventPollCleanupHandles:554 : Cleanup 8
  446. 2013-05-07 16:27:59.664+000016651: debug : virEventRunDefaultImpl:244 : running default event implementation
  447. 2013-05-07 16:27:59.664+000016651: debug : virEventPollCleanupTimeouts:506 : Cleanup 6
  448. 2013-05-07 16:27:59.664+000016651: debug : virEventPollCleanupHandles:554 : Cleanup 8
  449. 2013-05-07 16:27:59.664+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=0 w=1, f=7 e=1 d=0
  450. 2013-05-07 16:27:59.664+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=1 w=2, f=9 e=1 d=0
  451. 2013-05-07 16:27:59.664+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=2 w=3, f=11 e=1 d=0
  452. 2013-05-07 16:27:59.664+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=3 w=4, f=12 e=1 d=0
  453. 2013-05-07 16:27:59.664+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=4 w=5, f=13 e=1 d=0
  454. 2013-05-07 16:27:59.664+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=5 w=6, f=14 e=1 d=0
  455. 2013-05-07 16:27:59.664+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=6 w=7, f=15 e=1 d=0
  456. 2013-05-07 16:27:59.664+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=7 w=8, f=18 e=25 d=0
  457. 2013-05-07 16:27:59.664+000016651: debug : virEventPollCalculateTimeout:325 : Calculate expiry of 6 timers
  458. 2013-05-07 16:27:59.664+000016651: debug : virEventPollCalculateTimeout:331 : Got a timeout scheduled for 1367944081816
  459. 2013-05-07 16:27:59.664+000016651: debug : virEventPollCalculateTimeout:351 : Timeout at 1367944081816 due in 2152 ms
  460. 2013-05-07 16:27:59.664+000016651: debug : virEventPollRunOnce:619 : EVENT_POLL_RUN: nhandles=8 imeout=2152
  461. 2013-05-07 16:27:59.664+000016651: debug : virEventPollRunOnce:630 : Poll got 1 event(s)
  462. 2013-05-07 16:27:59.664+000016651: debug : virEventPollDispatchTimeouts:415 : Dispatch 6
  463. 2013-05-07 16:27:59.664+000016651: debug : virEventPollDispatchHandles:460 : Dispatch 8
  464. 2013-05-07 16:27:59.664+000016651: debug : virEventPollDispatchHandles:474 : i=0 w=1
  465. 2013-05-07 16:27:59.664+000016651: debug : virEventPollDispatchHandles:474 : i=1 w=2
  466. 2013-05-07 16:27:59.664+000016651: debug : virEventPollDispatchHandles:474 : i=2 w=3
  467. 2013-05-07 16:27:59.664+000016651: debug : virEventPollDispatchHandles:474 : i=3 w=4
  468. 2013-05-07 16:27:59.664+000016651: debug : virEventPollDispatchHandles:474 : i=4 w=5
  469. 2013-05-07 16:27:59.664+000016651: debug : virEventPollDispatchHandles:488 : EVENT_POLL_DISPATCH_HANDLE: watch=5 events=1
  470. 2013-05-07 16:27:59.664+000016651: debug : udevEventHandleCallback:1467 : udev action: 'remove'
  471. 2013-05-07 16:27:59.664+000016651: debug : udevRemoveOneDevice:1214 : Removing device 'net_vnet1_fe_54_00_db_37_69' with sysfs path '/sys/devices/virtual/net/vnet1'
  472. 2013-05-07 16:27:59.664+000016651: debug : virEventPollDispatchHandles:474 : i=5 w=6
  473. 2013-05-07 16:27:59.664+000016651: debug : virEventPollDispatchHandles:474 : i=6 w=7
  474. 2013-05-07 16:27:59.664+000016651: debug : virEventPollDispatchHandles:474 : i=7 w=8
  475. 2013-05-07 16:27:59.664+000016651: debug : virEventPollCleanupTimeouts:506 : Cleanup 6
  476. 2013-05-07 16:27:59.664+000016651: debug : virEventPollCleanupHandles:554 : Cleanup 8
  477. 2013-05-07 16:27:59.664+000016651: debug : virEventRunDefaultImpl:244 : running default event implementation
  478. 2013-05-07 16:27:59.664+000016651: debug : virEventPollCleanupTimeouts:506 : Cleanup 6
  479. 2013-05-07 16:27:59.664+000016651: debug : virEventPollCleanupHandles:554 : Cleanup 8
  480. 2013-05-07 16:27:59.664+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=0 w=1, f=7 e=1 d=0
  481. 2013-05-07 16:27:59.664+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=1 w=2, f=9 e=1 d=0
  482. 2013-05-07 16:27:59.664+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=2 w=3, f=11 e=1 d=0
  483. 2013-05-07 16:27:59.664+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=3 w=4, f=12 e=1 d=0
  484. 2013-05-07 16:27:59.664+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=4 w=5, f=13 e=1 d=0
  485. 2013-05-07 16:27:59.664+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=5 w=6, f=14 e=1 d=0
  486. 2013-05-07 16:27:59.664+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=6 w=7, f=15 e=1 d=0
  487. 2013-05-07 16:27:59.664+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=7 w=8, f=18 e=25 d=0
  488. 2013-05-07 16:27:59.664+000016651: debug : virEventPollCalculateTimeout:325 : Calculate expiry of 6 timers
  489. 2013-05-07 16:27:59.664+000016651: debug : virEventPollCalculateTimeout:331 : Got a timeout scheduled for 1367944081816
  490. 2013-05-07 16:27:59.664+000016651: debug : virEventPollCalculateTimeout:351 : Timeout at 1367944081816 due in 2152 ms
  491. 2013-05-07 16:27:59.664+000016651: debug : virEventPollRunOnce:619 : EVENT_POLL_RUN: nhandles=8 imeout=2152
  492. 2013-05-07 16:27:59.682+000016651: debug : virEventPollRunOnce:630 : Poll got 1 event(s)
  493. 2013-05-07 16:27:59.682+000016651: debug : virEventPollDispatchTimeouts:415 : Dispatch 6
  494. 2013-05-07 16:27:59.682+000016651: debug : virEventPollDispatchHandles:460 : Dispatch 8
  495. 2013-05-07 16:27:59.682+000016651: debug : virEventPollDispatchHandles:474 : i=0 w=1
  496. 2013-05-07 16:27:59.682+000016651: debug : virEventPollDispatchHandles:474 : i=1 w=2
  497. 2013-05-07 16:27:59.682+000016651: debug : virEventPollDispatchHandles:474 : i=2 w=3
  498. 2013-05-07 16:27:59.682+000016651: debug : virEventPollDispatchHandles:474 : i=3 w=4
  499. 2013-05-07 16:27:59.682+000016651: debug : virEventPollDispatchHandles:474 : i=4 w=5
  500. 2013-05-07 16:27:59.682+000016651: debug : virEventPollDispatchHandles:474 : i=5 w=6
  501. 2013-05-07 16:27:59.682+000016651: debug : virEventPollDispatchHandles:474 : i=6 w=7
  502. 2013-05-07 16:27:59.682+000016651: debug : virEventPollDispatchHandles:474 : i=7 w=8
  503. 2013-05-07 16:27:59.682+000016651: debug : virEventPollDispatchHandles:488 : EVENT_POLL_DISPATCH_HANDLE: watch=8 events=9
  504. 2013-05-07 16:27:59.682+000016651: debug : qemuMonitorRef:187 : QEMU_MONITOR_REF: mon=0xb0a02a98 refs=3
  505. 2013-05-07 16:27:59.682+000016651: error : qemuMonitorIO:560 : errore interno End of file from monitor
  506. 2013-05-07 16:27:59.682+000016651: debug : qemuMonitorIO:593 : Error on monitor errore interno End of file from monitor
  507. 2013-05-07 16:27:59.682+000016651: debug : virEventPollUpdateHandle:151 : EVENT_POLL_UPDATE_HANDLE: watch=8 events=12
  508. 2013-05-07 16:27:59.682+000016651: debug : virEventPollInterruptLocked:702 : Skip interrupt, 1 -1231796416
  509. 2013-05-07 16:27:59.682+000016651: debug : qemuMonitorUnref:196 : QEMU_MONITOR_UNREF: mon=0xb0a02a98 refs=2
  510. 2013-05-07 16:27:59.682+000016651: debug : qemuMonitorIO:616 : Triggering EOF callback
  511. 2013-05-07 16:27:59.682+000016651: debug : qemuProcessHandleMonitorEOF:126 : Received EOF on 0xb0e111e8 'uno'
  512. 2013-05-07 16:27:59.682+000016651: debug : qemuProcessStop:3380 : Shutting down VM 'uno' pid=17497 migrated=0
  513. 2013-05-07 16:27:59.682+000016651: debug : qemuMonitorClose:745 : QEMU_MONITOR_CLOSE: mon=0xb0a02a98 refs=2
  514. 2013-05-07 16:27:59.682+000016651: debug : virEventPollRemoveHandle:180 : EVENT_POLL_REMOVE_HANDLE: watch=8
  515. 2013-05-07 16:27:59.682+000016651: debug : virEventPollRemoveHandle:193 : mark delete 7 18
  516. 2013-05-07 16:27:59.682+000016651: debug : virEventPollInterruptLocked:702 : Skip interrupt, 1 -1231796416
  517. 2013-05-07 16:27:59.682+000016651: debug : qemuMonitorUnref:196 : QEMU_MONITOR_UNREF: mon=0xb0a02a98 refs=1
  518. 2013-05-07 16:27:59.682+000016651: debug : qemuProcessKill:3326 : vm=uno pid=17497 gracefully=0
  519. 2013-05-07 16:27:59.682+000016651: debug : qemuProcessAutoDestroyRemove:3849 : vm=uno uuid=fc093b54-5e91-9890-d48e-790b15bfe5f1
  520. 2013-05-07 16:27:59.682+000016651: debug : virSecurityDACRestoreSecurityAllLabel:504 : Restoring security label on uno migrated=0
  521. 2013-05-07 16:27:59.682+000016651: info : virSecurityDACRestoreSecurityFileLabel:139 : Restoring DAC user and group on '/var/lib/libvirt/images/cloud/uno.img'
  522. 2013-05-07 16:27:59.683+000016651: info : virSecurityDACSetOwnership:99 : Setting DAC user and group on '/var/lib/libvirt/images/cloud/uno.img' to '0:0'
  523. 2013-05-07 16:27:59.684+000016651: info : virSecurityDACSetOwnership:115 : Setting user and group to '0:0' on '/var/lib/libvirt/images/cloud/uno.img' not supported by filesystem
  524. 2013-05-07 16:27:59.684+000016651: debug : virCgroupNew:602 : New group /libvirt/qemu/uno
  525. 2013-05-07 16:27:59.684+000016651: debug : virCgroupDetect:261 : Detected mount/mapping 0:cpu at /sys/fs/cgroup/cpu in
  526. 2013-05-07 16:27:59.684+000016651: debug : virCgroupDetect:261 : Detected mount/mapping 1:cpuacct at /sys/fs/cgroup/cpuacct in
  527. 2013-05-07 16:27:59.684+000016651: debug : virCgroupDetect:261 : Detected mount/mapping 2:cpuset at /sys/fs/cgroup/cpuset in
  528. 2013-05-07 16:27:59.684+000016651: debug : virCgroupDetect:261 : Detected mount/mapping 3:memory at /sys/fs/cgroup/memory in
  529. 2013-05-07 16:27:59.684+000016651: debug : virCgroupDetect:261 : Detected mount/mapping 4:devices at /sys/fs/cgroup/devices in
  530. 2013-05-07 16:27:59.684+000016651: debug : virCgroupDetect:261 : Detected mount/mapping 5:freezer at /sys/fs/cgroup/freezer in
  531. 2013-05-07 16:27:59.684+000016651: debug : virCgroupDetect:261 : Detected mount/mapping 6:blkio at /sys/fs/cgroup/blkio in
  532. 2013-05-07 16:27:59.684+000016651: debug : virCgroupMakeGroup:523 : Make group /libvirt/qemu/uno
  533. 2013-05-07 16:27:59.684+000016651: debug : virCgroupMakeGroup:545 : Make controller /sys/fs/cgroup/cpu/libvirt/qemu/uno/
  534. 2013-05-07 16:27:59.684+000016651: debug : virCgroupMakeGroup:545 : Make controller /sys/fs/cgroup/cpuacct/libvirt/qemu/uno/
  535. 2013-05-07 16:27:59.684+000016651: debug : virCgroupMakeGroup:545 : Make controller /sys/fs/cgroup/cpuset/libvirt/qemu/uno/
  536. 2013-05-07 16:27:59.684+000016651: debug : virCgroupMakeGroup:545 : Make controller /sys/fs/cgroup/memory/libvirt/qemu/uno/
  537. 2013-05-07 16:27:59.684+000016651: debug : virCgroupMakeGroup:545 : Make controller /sys/fs/cgroup/devices/libvirt/qemu/uno/
  538. 2013-05-07 16:27:59.684+000016651: debug : virCgroupMakeGroup:545 : Make controller /sys/fs/cgroup/freezer/libvirt/qemu/uno/
  539. 2013-05-07 16:27:59.684+000016651: debug : virCgroupMakeGroup:545 : Make controller /sys/fs/cgroup/blkio/libvirt/qemu/uno/
  540. 2013-05-07 16:27:59.684+000016651: debug : virCgroupRemove:757 : Removing cgroup /sys/fs/cgroup/cpu/libvirt/qemu/uno/ and all child cgroups
  541. 2013-05-07 16:27:59.684+000016651: debug : virCgroupRemoveRecursively:712 : Removing cgroup /sys/fs/cgroup/cpu/libvirt/qemu/uno//vcpu0
  542. 2013-05-07 16:27:59.694+000016651: debug : virCgroupRemoveRecursively:712 : Removing cgroup /sys/fs/cgroup/cpu/libvirt/qemu/uno/
  543. 2013-05-07 16:27:59.710+000016651: debug : virCgroupRemove:757 : Removing cgroup /sys/fs/cgroup/cpuacct/libvirt/qemu/uno/ and all child cgroups
  544. 2013-05-07 16:27:59.710+000016651: debug : virCgroupRemoveRecursively:712 : Removing cgroup /sys/fs/cgroup/cpuacct/libvirt/qemu/uno/
  545. 2013-05-07 16:27:59.730+000016651: debug : virCgroupRemove:757 : Removing cgroup /sys/fs/cgroup/cpuset/libvirt/qemu/uno/ and all child cgroups
  546. 2013-05-07 16:27:59.730+000016651: debug : virCgroupRemoveRecursively:712 : Removing cgroup /sys/fs/cgroup/cpuset/libvirt/qemu/uno/
  547. 2013-05-07 16:27:59.730+000016651: debug : virCgroupRemove:757 : Removing cgroup /sys/fs/cgroup/memory/libvirt/qemu/uno/ and all child cgroups
  548. 2013-05-07 16:27:59.730+000016651: debug : virCgroupRemoveRecursively:712 : Removing cgroup /sys/fs/cgroup/memory/libvirt/qemu/uno/
  549. 2013-05-07 16:27:59.746+000016651: debug : virCgroupRemove:757 : Removing cgroup /sys/fs/cgroup/devices/libvirt/qemu/uno/ and all child cgroups
  550. 2013-05-07 16:27:59.746+000016651: debug : virCgroupRemoveRecursively:712 : Removing cgroup /sys/fs/cgroup/devices/libvirt/qemu/uno/
  551. 2013-05-07 16:27:59.746+000016651: debug : virCgroupRemove:757 : Removing cgroup /sys/fs/cgroup/freezer/libvirt/qemu/uno/ and all child cgroups
  552. 2013-05-07 16:27:59.746+000016651: debug : virCgroupRemoveRecursively:712 : Removing cgroup /sys/fs/cgroup/freezer/libvirt/qemu/uno/
  553. 2013-05-07 16:27:59.750+000016651: debug : virCgroupRemove:757 : Removing cgroup /sys/fs/cgroup/blkio/libvirt/qemu/uno/ and all child cgroups
  554. 2013-05-07 16:27:59.750+000016651: debug : virCgroupRemoveRecursively:712 : Removing cgroup /sys/fs/cgroup/blkio/libvirt/qemu/uno/
  555. 2013-05-07 16:27:59.754+000016651: debug : virEventPollUpdateTimeout:259 : EVENT_POLL_UPDATE_TIMEOUT: timer=1 frequency=0
  556. 2013-05-07 16:27:59.754+000016651: debug : virEventPollInterruptLocked:702 : Skip interrupt, 1 -1231796416
  557. 2013-05-07 16:27:59.754+000016651: debug : virEventPollCleanupTimeouts:506 : Cleanup 6
  558. 2013-05-07 16:27:59.754+000016651: debug : virEventPollCleanupHandles:554 : Cleanup 8
  559. 2013-05-07 16:27:59.754+000016651: debug : virEventPollCleanupHandles:567 : EVENT_POLL_PURGE_HANDLE: watch=8
  560. 2013-05-07 16:27:59.754+000016651: debug : qemuMonitorUnref:196 : QEMU_MONITOR_UNREF: mon=0xb0a02a98 refs=0
  561. 2013-05-07 16:27:59.754+000016651: debug : qemuMonitorFree:173 : mon=0xb0a02a98
  562. 2013-05-07 16:27:59.754+000016651: debug : virDomainObjUnref:1515 : obj=0xb0e111e8 refs=1
  563. 2013-05-07 16:27:59.754+000016651: debug : virEventRunDefaultImpl:244 : running default event implementation
  564. 2013-05-07 16:27:59.754+000016651: debug : virEventPollCleanupTimeouts:506 : Cleanup 6
  565. 2013-05-07 16:27:59.754+000016651: debug : virEventPollCleanupHandles:554 : Cleanup 7
  566. 2013-05-07 16:27:59.754+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=0 w=1, f=7 e=1 d=0
  567. 2013-05-07 16:27:59.754+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=1 w=2, f=9 e=1 d=0
  568. 2013-05-07 16:27:59.754+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=2 w=3, f=11 e=1 d=0
  569. 2013-05-07 16:27:59.754+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=3 w=4, f=12 e=1 d=0
  570. 2013-05-07 16:27:59.754+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=4 w=5, f=13 e=1 d=0
  571. 2013-05-07 16:27:59.754+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=5 w=6, f=14 e=1 d=0
  572. 2013-05-07 16:27:59.754+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=6 w=7, f=15 e=1 d=0
  573. 2013-05-07 16:27:59.754+000016651: debug : virEventPollCalculateTimeout:325 : Calculate expiry of 6 timers
  574. 2013-05-07 16:27:59.754+000016651: debug : virEventPollCalculateTimeout:331 : Got a timeout scheduled for 1367944079754
  575. 2013-05-07 16:27:59.754+000016651: debug : virEventPollCalculateTimeout:331 : Got a timeout scheduled for 1367944081816
  576. 2013-05-07 16:27:59.754+000016651: debug : virEventPollCalculateTimeout:351 : Timeout at 1367944079754 due in 0 ms
  577. 2013-05-07 16:27:59.754+000016651: debug : virEventPollRunOnce:619 : EVENT_POLL_RUN: nhandles=7 imeout=0
  578. 2013-05-07 16:27:59.754+000016651: debug : virEventPollRunOnce:630 : Poll got 1 event(s)
  579. 2013-05-07 16:27:59.754+000016651: debug : virEventPollDispatchTimeouts:415 : Dispatch 6
  580. 2013-05-07 16:27:59.754+000016651: debug : virEventPollDispatchTimeouts:438 : EVENT_POLL_DISPATCH_TIMEOUT: timer=1
  581. 2013-05-07 16:27:59.754+000016651: debug : virEventPollUpdateTimeout:259 : EVENT_POLL_UPDATE_TIMEOUT: timer=1 frequency=-1
  582. 2013-05-07 16:27:59.754+000016651: debug : virEventPollInterruptLocked:702 : Skip interrupt, 1 -1231796416
  583. 2013-05-07 16:27:59.754+000016651: debug : virEventPollDispatchHandles:460 : Dispatch 7
  584. 2013-05-07 16:27:59.754+000016651: debug : virEventPollDispatchHandles:474 : i=0 w=1
  585. 2013-05-07 16:27:59.754+000016651: debug : virEventPollDispatchHandles:474 : i=1 w=2
  586. 2013-05-07 16:27:59.754+000016651: debug : virEventPollDispatchHandles:474 : i=2 w=3
  587. 2013-05-07 16:27:59.754+000016651: debug : virEventPollDispatchHandles:474 : i=3 w=4
  588. 2013-05-07 16:27:59.754+000016651: debug : virEventPollDispatchHandles:474 : i=4 w=5
  589. 2013-05-07 16:27:59.754+000016651: debug : virEventPollDispatchHandles:474 : i=5 w=6
  590. 2013-05-07 16:27:59.754+000016651: debug : virEventPollDispatchHandles:474 : i=6 w=7
  591. 2013-05-07 16:27:59.754+000016651: debug : virEventPollDispatchHandles:488 : EVENT_POLL_DISPATCH_HANDLE: watch=7 events=1
  592. 2013-05-07 16:27:59.754+000016651: debug : virNetMessageDecodeLength:149 : Got length, now need 96 total (92 more)
  593. 2013-05-07 16:27:59.754+000016651: debug : virNetServerClientCalculateHandleMode:137 : tls=(nil) hs=-1, rx=0x9faf1e8 tx=(nil)
  594. 2013-05-07 16:27:59.754+000016651: debug : virNetServerClientCalculateHandleMode:167 : mode=1
  595. 2013-05-07 16:27:59.754+000016651: debug : virEventPollUpdateHandle:151 : EVENT_POLL_UPDATE_HANDLE: watch=7 events=1
  596. 2013-05-07 16:27:59.754+000016651: debug : virEventPollInterruptLocked:702 : Skip interrupt, 1 -1231796416
  597. 2013-05-07 16:27:59.754+000016651: debug : virNetServerClientDispatchRead:886 : RPC_SERVER_CLIENT_MSG_RX: client=0x9f9c638 len=96 prog=536903814 vers=1 proc=217 type=0 status=0 serial=5
  598. 2013-05-07 16:27:59.754+000016651: debug : virKeepAliveCheckMessage:408 : ka=0x9f95908, client=0x9f9c638, msg=0x9faf1e8
  599. 2013-05-07 16:27:59.754+000016651: debug : virEventPollUpdateTimeout:259 : EVENT_POLL_UPDATE_TIMEOUT: timer=6 frequency=5000
  600. 2013-05-07 16:27:59.754+000016651: debug : virEventPollInterruptLocked:702 : Skip interrupt, 1 -1231796416
  601. 2013-05-07 16:27:59.754+000016651: debug : virNetServerDispatchNewMessage:199 : server=0x9f95fd0 client=0x9f9c638 message=0x9faf1e8
  602. 2013-05-07 16:27:59.754+000016651: debug : virNetServerProgramRef:87 : prog=0x9f96b50 refs=3
  603. 2013-05-07 16:27:59.755+000016652: debug : virNetServerHandleJob:138 : server=0x9f95fd0 client=0x9f9c638 message=0x9faf1e8 prog=0x9f96b50
  604. 2013-05-07 16:27:59.755+000016652: debug : virNetServerProgramDispatch:269 : prog=536903814 ver=1 type=0 status=0 serial=5 proc=217
  605. 2013-05-07 16:27:59.755+000016651: debug : virNetMessageNew:48 : msg=0x9fef230 tracked=1
  606. 2013-05-07 16:27:59.755+000016651: debug : virNetServerClientCalculateHandleMode:137 : tls=(nil) hs=-1, rx=0x9fef230 tx=(nil)
  607. 2013-05-07 16:27:59.755+000016651: debug : virNetServerClientCalculateHandleMode:167 : mode=1
  608. 2013-05-07 16:27:59.755+000016651: debug : virEventPollUpdateHandle:151 : EVENT_POLL_UPDATE_HANDLE: watch=7 events=1
  609. 2013-05-07 16:27:59.755+000016651: debug : virEventPollInterruptLocked:702 : Skip interrupt, 1 -1231796416
  610. 2013-05-07 16:27:59.755+000016651: debug : virEventPollCleanupTimeouts:506 : Cleanup 6
  611. 2013-05-07 16:27:59.755+000016651: debug : virEventPollCleanupHandles:554 : Cleanup 7
  612. 2013-05-07 16:27:59.755+000016651: debug : virEventRunDefaultImpl:244 : running default event implementation
  613. 2013-05-07 16:27:59.755+000016652: debug : remoteDispatchDomainMigrateFinish3Helper:2948 : server=0x9f95fd0 client=0x9f9c638 msg=0x9faf1e8 rerr=0xb670f1b8 args=0xb0e4d3f8 ret=0xb0e5a988
  614. 2013-05-07 16:27:59.755+000016651: debug : virEventPollCleanupTimeouts:506 : Cleanup 6
  615. 2013-05-07 16:27:59.755+000016651: debug : virEventPollCleanupHandles:554 : Cleanup 7
  616. 2013-05-07 16:27:59.755+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=0 w=1, f=7 e=1 d=0
  617. 2013-05-07 16:27:59.755+000016652: debug : virDomainMigrateFinish3:5997 : dconn=0xb0a00568, dname=uno, cookiein=(nil), cookieinlen=0, cookieout=0xb670f0f4,cookieoutlen=0xb670f0f8, dconnuri=(null), uri=tcp:ubuntu.ubuntu-domain:49152, flags=1, retcode=1
  618. 2013-05-07 16:27:59.755+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=1 w=2, f=9 e=1 d=0
  619. 2013-05-07 16:27:59.755+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=2 w=3, f=11 e=1 d=0
  620. 2013-05-07 16:27:59.755+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=3 w=4, f=12 e=1 d=0
  621. 2013-05-07 16:27:59.755+000016652: debug : qemuMigrationFinish:3302 : driver=0xb0e4e0c0, dconn=0xb0a00568, vm=0xb0e111e8, cookiein=(null), cookieinlen=0, cookieout=0xb670f0f4, cookieoutlen=0xb670f0f8, flags=1, retcode=1
  622. 2013-05-07 16:27:59.755+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=4 w=5, f=13 e=1 d=0
  623. 2013-05-07 16:27:59.755+000016652: debug : virDomainObjRef:1508 : obj=0xb0e111e8 refs=2
  624. 2013-05-07 16:27:59.755+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=5 w=6, f=14 e=1 d=0
  625. 2013-05-07 16:27:59.755+000016652: debug : qemuMigrationEatCookie:1456 : cookielen=0 cookie='(null)'
  626. 2013-05-07 16:27:59.755+000016651: debug : virEventPollMakePollFDs:383 : Prepare n=6 w=7, f=15 e=1 d=0
  627. 2013-05-07 16:27:59.755+000016651: debug : virEventPollCalculateTimeout:325 : Calculate expiry of 6 timers
  628. 2013-05-07 16:27:59.755+000016651: debug : virEventPollCalculateTimeout:331 : Got a timeout scheduled for 1367944084754
  629. 2013-05-07 16:27:59.755+000016651: debug : virEventPollCalculateTimeout:351 : Timeout at 1367944084754 due in 4999 ms
  630. 2013-05-07 16:27:59.755+000016651: debug : virEventPollRunOnce:619 : EVENT_POLL_RUN: nhandles=7 imeout=4999
  631. 2013-05-07 16:27:59.755+000016652: debug : qemuProcessStop:3380 : Shutting down VM 'uno' pid=-1 migrated=1
  632. 2013-05-07 16:27:59.755+000016652: debug : qemuProcessStop:3383 : VM 'uno' not active
  633. 2013-05-07 16:27:59.755+000016652: debug : qemuMigrationBakeCookie:1433 : cookielen=211 cookie=<qemu-migration>
  634. <name>uno</name>
  635. <uuid>fc093b54-5e91-9890-d48e-790b15bfe5f1</uuid>
  636. <hostname>ubuntu.ubuntu-domain</hostname>
  637. <hostuuid>44454c4c-3000-1031-8057-c3c04f42344a</hostuuid>
  638. </qemu-migration>
  639. 
  640. 2013-05-07 16:27:59.755+000016652: debug : qemuDomainObjEndAsyncJob:900 : Stopping async job: migration in
  641. 2013-05-07 16:27:59.755+000016652: debug : virDomainObjUnref:1515 : obj=0xb0e111e8 refs=1
  642. 
  643. 
  644. ====== end of log =====
  645.