Login
[x]
Log in using an account from:
Fedora Account System
Red Hat Associate
Red Hat Customer
Or login using a Red Hat Bugzilla account
Forgot Password
Login:
Hide Forgot
Create an Account
Red Hat Bugzilla – Attachment 641268 Details for
Bug 872420
pm-hibernate exit code does not indicate failure when s4 fails
[?]
New
Simple Search
Advanced Search
My Links
Browse
Requests
Reports
Current State
Search
Tabular reports
Graphical reports
Duplicates
Other Reports
User Changes
Plotly Reports
Bug Status
Bug Severity
Non-Defaults
|
Product Dashboard
Help
Page Help!
Bug Writing Guidelines
What's new
Browser Support Policy
5.0.4.rh83 Release notes
FAQ
Guides index
User guide
Web Services
Contact
Legal
This site requires JavaScript to be enabled to function correctly, please enable it.
crashed libvirtd log
libvirtd.log (text/plain), 64.83 KB, created by
EricLee
on 2012-11-09 06:03:21 UTC
(
hide
)
Description:
crashed libvirtd log
Filename:
MIME Type:
Creator:
EricLee
Created:
2012-11-09 06:03:21 UTC
Size:
64.83 KB
patch
obsolete
>2012-11-09 05:51:57.996+0000: 5685: warning : virCgroupMoveTask:885 : no vm cgroup in controller 3 >2012-11-09 05:51:57.996+0000: 5685: warning : virCgroupMoveTask:885 : no vm cgroup in controller 4 >2012-11-09 05:51:57.996+0000: 5685: warning : virCgroupMoveTask:885 : no vm cgroup in controller 6 >2012-11-09 06:00:29.448+0000: 5683: error : virNetSocketReadWire:1184 : End of file while reading data: Input/output error >2012-11-09 06:00:40.673+0000: 5683: warning : qemuAgentNotifyEvent:1274 : Received unexpected event 1 >2012-11-09 06:00:40.679+0000: 5683: error : qemuMonitorIO:613 : internal error End of file from monitor >2012-11-09 06:00:40.679+0000: 5683: error : qemuAgentIO:642 : internal error End of file from monitor >Caught Segmentation violation dumping internal log buffer: > > > ====== start of log ===== > >eouts:501 : Cleanup 6 >2012-11-09 06:00:40.198+00005683: debug : virEventPollCleanupHandles:549 : Cleanup 12 >2012-11-09 06:00:40.198+00005690: debug : virConnectOpen:1331 : name= >2012-11-09 06:00:40.198+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=0 w=1, f=7 e=1 d=0 >2012-11-09 06:00:40.198+00005690: debug : virObjectNew:110 : OBJECT_NEW: obj=0x7f3af0181df0 classname=virConnect >2012-11-09 06:00:40.198+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=1 w=2, f=9 e=1 d=0 >2012-11-09 06:00:40.198+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=2 w=3, f=12 e=1 d=0 >2012-11-09 06:00:40.198+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=3 w=4, f=13 e=1 d=0 >2012-11-09 06:00:40.198+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=4 w=5, f=14 e=1 d=0 >2012-11-09 06:00:40.198+00005690: debug : virConnectGetConfigFile:953 : Loading config file '/etc/libvirt/libvirt.conf' >2012-11-09 06:00:40.198+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=5 w=6, f=16 e=1 d=0 >2012-11-09 06:00:40.198+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=6 w=7, f=17 e=1 d=0 >2012-11-09 06:00:40.198+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=7 w=10, f=24 e=25 d=0 >2012-11-09 06:00:40.198+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=8 w=11, f=23 e=25 d=0 >2012-11-09 06:00:40.198+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=9 w=13, f=22 e=1 d=0 >2012-11-09 06:00:40.198+00005690: debug : virFileClose:72 : Closed fd 28 >2012-11-09 06:00:40.198+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=10 w=14, f=19 e=1 d=0 >2012-11-09 06:00:40.198+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=11 w=15, f=27 e=1 d=0 >2012-11-09 06:00:40.198+00005683: debug : virEventPollCalculateTimeout:320 : Calculate expiry of 6 timers >2012-11-09 06:00:40.198+00005683: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1352440843209 >2012-11-09 06:00:40.198+00005690: debug : do_open:1131 : no name, allowing driver auto-select >2012-11-09 06:00:40.198+00005683: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1352440844024 >2012-11-09 06:00:40.198+00005690: debug : do_open:1174 : trying driver 0 (Test) ... >2012-11-09 06:00:40.198+00005683: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1352440845198 >2012-11-09 06:00:40.198+00005690: debug : do_open:1180 : driver 0 Test returned DECLINED >2012-11-09 06:00:40.198+00005683: debug : virEventPollCalculateTimeout:346 : Timeout at 1352440843209 due in 3011 ms >2012-11-09 06:00:40.198+00005690: debug : do_open:1174 : trying driver 1 (ESX) ... >2012-11-09 06:00:40.198+00005683: debug : virEventPollRunOnce:614 : EVENT_POLL_RUN: nhandles=12 timeout=3011 >2012-11-09 06:00:40.198+00005690: debug : do_open:1180 : driver 1 ESX returned DECLINED >2012-11-09 06:00:40.198+00005690: debug : do_open:1174 : trying driver 2 (remote) ... >2012-11-09 06:00:40.198+00005690: debug : do_open:1180 : driver 2 remote returned DECLINED >2012-11-09 06:00:40.198+00005690: debug : do_open:1174 : trying driver 3 (QEMU) ... >2012-11-09 06:00:40.198+00005690: debug : do_open:1180 : driver 3 QEMU returned SUCCESS >2012-11-09 06:00:40.198+00005690: debug : do_open:1202 : network driver 0 Test returned DECLINED >2012-11-09 06:00:40.198+00005690: debug : do_open:1202 : network driver 1 ESX returned DECLINED >2012-11-09 06:00:40.198+00005690: debug : do_open:1202 : network driver 2 remote returned DECLINED >2012-11-09 06:00:40.198+00005690: debug : do_open:1202 : network driver 3 Network returned SUCCESS >2012-11-09 06:00:40.198+00005690: debug : do_open:1217 : interface driver 0 Test returned DECLINED >2012-11-09 06:00:40.198+00005690: debug : do_open:1217 : interface driver 1 ESX returned DECLINED >2012-11-09 06:00:40.198+00005690: debug : do_open:1217 : interface driver 2 remote returned DECLINED >2012-11-09 06:00:40.205+00005690: debug : do_open:1217 : interface driver 3 Interface returned SUCCESS >2012-11-09 06:00:40.205+00005690: debug : do_open:1233 : storage driver 0 Test returned DECLINED >2012-11-09 06:00:40.205+00005690: debug : do_open:1233 : storage driver 1 ESX returned DECLINED >2012-11-09 06:00:40.205+00005690: debug : do_open:1233 : storage driver 2 remote returned DECLINED >2012-11-09 06:00:40.205+00005690: debug : do_open:1233 : storage driver 3 storage returned SUCCESS >2012-11-09 06:00:40.205+00005690: debug : do_open:1249 : node driver 0 Test returned DECLINED >2012-11-09 06:00:40.205+00005690: debug : do_open:1249 : node driver 1 ESX returned DECLINED >2012-11-09 06:00:40.205+00005690: debug : do_open:1249 : node driver 2 remote returned DECLINED >2012-11-09 06:00:40.205+00005690: debug : do_open:1249 : node driver 3 udevDeviceMonitor returned SUCCESS >2012-11-09 06:00:40.205+00005690: debug : do_open:1265 : secret driver 0 Test returned DECLINED >2012-11-09 06:00:40.205+00005690: debug : do_open:1265 : secret driver 1 ESX returned DECLINED >2012-11-09 06:00:40.205+00005690: debug : do_open:1265 : secret driver 2 remote returned DECLINED >2012-11-09 06:00:40.205+00005690: debug : do_open:1265 : secret driver 3 secret returned SUCCESS >2012-11-09 06:00:40.205+00005690: debug : do_open:1281 : nwfilter driver 0 Test returned DECLINED >2012-11-09 06:00:40.205+00005690: debug : do_open:1281 : nwfilter driver 1 ESX returned DECLINED >2012-11-09 06:00:40.205+00005690: debug : do_open:1281 : nwfilter driver 2 remote returned DECLINED >2012-11-09 06:00:40.205+00005690: debug : do_open:1281 : nwfilter driver 3 nwfilter returned SUCCESS >2012-11-09 06:00:40.205+00005690: debug : virNetMessageEncodePayload:358 : Encode length as 28 >2012-11-09 06:00:40.205+00005690: debug : virNetServerClientSendMessageLocked:1116 : msg=0x12e6a10 proc=1 len=28 offset=0 >2012-11-09 06:00:40.205+00005690: debug : virNetServerClientSendMessageLocked:1124 : RPC_SERVER_CLIENT_MSG_TX_QUEUE: client=0x12e8cc0 len=28 prog=536903814 vers=1 proc=1 type=1 status=0 serial=2 >2012-11-09 06:00:40.205+00005690: debug : virNetServerClientCalculateHandleMode:152 : tls=(nil) hs=-1, rx=0x12e6b80 tx=0x12e6a10 >2012-11-09 06:00:40.205+00005690: debug : virNetServerClientCalculateHandleMode:183 : mode=3 >2012-11-09 06:00:40.205+00005690: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=15 events=3 >2012-11-09 06:00:40.205+00005690: debug : virEventPollInterruptLocked:701 : Interrupting >2012-11-09 06:00:40.205+00005690: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x12e9fd0 >2012-11-09 06:00:40.205+00005690: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x12e8cc0 >2012-11-09 06:00:40.205+00005683: debug : virEventPollRunOnce:625 : Poll got 1 event(s) >2012-11-09 06:00:40.205+00005683: debug : virEventPollDispatchTimeouts:410 : Dispatch 6 >2012-11-09 06:00:40.205+00005683: debug : virEventPollDispatchHandles:455 : Dispatch 12 >2012-11-09 06:00:40.205+00005683: debug : virEventPollDispatchHandles:469 : i=0 w=1 >2012-11-09 06:00:40.205+00005683: debug : virEventPollDispatchHandles:483 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 >2012-11-09 06:00:40.205+00005683: debug : virEventPollDispatchHandles:469 : i=1 w=2 >2012-11-09 06:00:40.205+00005683: debug : virEventPollDispatchHandles:469 : i=2 w=3 >2012-11-09 06:00:40.205+00005683: debug : virEventPollDispatchHandles:469 : i=3 w=4 >2012-11-09 06:00:40.205+00005683: debug : virEventPollDispatchHandles:469 : i=4 w=5 >2012-11-09 06:00:40.205+00005683: debug : virEventPollDispatchHandles:469 : i=5 w=6 >2012-11-09 06:00:40.205+00005683: debug : virEventPollDispatchHandles:469 : i=6 w=7 >2012-11-09 06:00:40.205+00005683: debug : virEventPollDispatchHandles:469 : i=7 w=10 >2012-11-09 06:00:40.205+00005683: debug : virEventPollDispatchHandles:469 : i=8 w=11 >2012-11-09 06:00:40.205+00005683: debug : virEventPollDispatchHandles:469 : i=9 w=13 >2012-11-09 06:00:40.205+00005683: debug : virEventPollDispatchHandles:469 : i=10 w=14 >2012-11-09 06:00:40.205+00005683: debug : virEventPollDispatchHandles:469 : i=11 w=15 >2012-11-09 06:00:40.205+00005683: debug : virEventPollCleanupTimeouts:501 : Cleanup 6 >2012-11-09 06:00:40.205+00005683: debug : virEventPollCleanupHandles:549 : Cleanup 12 >2012-11-09 06:00:40.205+00005683: debug : virEventRunDefaultImpl:244 : running default event implementation >2012-11-09 06:00:40.205+00005683: debug : virEventPollCleanupTimeouts:501 : Cleanup 6 >2012-11-09 06:00:40.205+00005683: debug : virEventPollCleanupHandles:549 : Cleanup 12 >2012-11-09 06:00:40.205+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=0 w=1, f=7 e=1 d=0 >2012-11-09 06:00:40.205+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=1 w=2, f=9 e=1 d=0 >2012-11-09 06:00:40.205+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=2 w=3, f=12 e=1 d=0 >2012-11-09 06:00:40.205+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=3 w=4, f=13 e=1 d=0 >2012-11-09 06:00:40.205+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=4 w=5, f=14 e=1 d=0 >2012-11-09 06:00:40.205+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=5 w=6, f=16 e=1 d=0 >2012-11-09 06:00:40.205+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=6 w=7, f=17 e=1 d=0 >2012-11-09 06:00:40.205+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=7 w=10, f=24 e=25 d=0 >2012-11-09 06:00:40.205+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=8 w=11, f=23 e=25 d=0 >2012-11-09 06:00:40.205+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=9 w=13, f=22 e=1 d=0 >2012-11-09 06:00:40.205+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=10 w=14, f=19 e=1 d=0 >2012-11-09 06:00:40.205+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=11 w=15, f=27 e=5 d=0 >2012-11-09 06:00:40.205+00005683: debug : virEventPollCalculateTimeout:320 : Calculate expiry of 6 timers >2012-11-09 06:00:40.205+00005683: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1352440843209 >2012-11-09 06:00:40.205+00005683: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1352440844024 >2012-11-09 06:00:40.205+00005683: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1352440845198 >2012-11-09 06:00:40.205+00005683: debug : virEventPollCalculateTimeout:346 : Timeout at 1352440843209 due in 3004 ms >2012-11-09 06:00:40.205+00005683: debug : virEventPollRunOnce:614 : EVENT_POLL_RUN: nhandles=12 timeout=3004 >2012-11-09 06:00:40.205+00005683: debug : virEventPollRunOnce:625 : Poll got 1 event(s) >2012-11-09 06:00:40.205+00005683: debug : virEventPollDispatchTimeouts:410 : Dispatch 6 >2012-11-09 06:00:40.205+00005683: debug : virEventPollDispatchHandles:455 : Dispatch 12 >2012-11-09 06:00:40.205+00005683: debug : virEventPollDispatchHandles:469 : i=0 w=1 >2012-11-09 06:00:40.205+00005683: debug : virEventPollDispatchHandles:469 : i=1 w=2 >2012-11-09 06:00:40.205+00005683: debug : virEventPollDispatchHandles:469 : i=2 w=3 >2012-11-09 06:00:40.205+00005683: debug : virEventPollDispatchHandles:469 : i=3 w=4 >2012-11-09 06:00:40.205+00005683: debug : virEventPollDispatchHandles:469 : i=4 w=5 >2012-11-09 06:00:40.205+00005683: debug : virEventPollDispatchHandles:469 : i=5 w=6 >2012-11-09 06:00:40.205+00005683: debug : virEventPollDispatchHandles:469 : i=6 w=7 >2012-11-09 06:00:40.205+00005683: debug : virEventPollDispatchHandles:469 : i=7 w=10 >2012-11-09 06:00:40.205+00005683: debug : virEventPollDispatchHandles:469 : i=8 w=11 >2012-11-09 06:00:40.205+00005683: debug : virEventPollDispatchHandles:469 : i=9 w=13 >2012-11-09 06:00:40.205+00005683: debug : virEventPollDispatchHandles:469 : i=10 w=14 >2012-11-09 06:00:40.205+00005683: debug : virEventPollDispatchHandles:469 : i=11 w=15 >2012-11-09 06:00:40.205+00005683: debug : virEventPollDispatchHandles:483 : EVENT_POLL_DISPATCH_HANDLE: watch=15 events=2 >2012-11-09 06:00:40.205+00005683: debug : virNetMessageFree:73 : msg=0x12e6a10 nfds=0 cb=(nil) >2012-11-09 06:00:40.205+00005683: debug : virNetServerClientCalculateHandleMode:152 : tls=(nil) hs=-1, rx=0x12e6b80 tx=(nil) >2012-11-09 06:00:40.205+00005683: debug : virNetServerClientCalculateHandleMode:183 : mode=1 >2012-11-09 06:00:40.205+00005683: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=15 events=1 >2012-11-09 06:00:40.205+00005683: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 603646048 >2012-11-09 06:00:40.205+00005683: debug : virEventPollCleanupTimeouts:501 : Cleanup 6 >2012-11-09 06:00:40.205+00005683: debug : virEventPollCleanupHandles:549 : Cleanup 12 >2012-11-09 06:00:40.205+00005683: debug : virEventRunDefaultImpl:244 : running default event implementation >2012-11-09 06:00:40.205+00005683: debug : virEventPollCleanupTimeouts:501 : Cleanup 6 >2012-11-09 06:00:40.205+00005683: debug : virEventPollCleanupHandles:549 : Cleanup 12 >2012-11-09 06:00:40.205+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=0 w=1, f=7 e=1 d=0 >2012-11-09 06:00:40.205+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=1 w=2, f=9 e=1 d=0 >2012-11-09 06:00:40.205+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=2 w=3, f=12 e=1 d=0 >2012-11-09 06:00:40.205+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=3 w=4, f=13 e=1 d=0 >2012-11-09 06:00:40.205+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=4 w=5, f=14 e=1 d=0 >2012-11-09 06:00:40.205+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=5 w=6, f=16 e=1 d=0 >2012-11-09 06:00:40.205+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=6 w=7, f=17 e=1 d=0 >2012-11-09 06:00:40.205+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=7 w=10, f=24 e=25 d=0 >2012-11-09 06:00:40.205+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=8 w=11, f=23 e=25 d=0 >2012-11-09 06:00:40.205+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=9 w=13, f=22 e=1 d=0 >2012-11-09 06:00:40.205+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=10 w=14, f=19 e=1 d=0 >2012-11-09 06:00:40.205+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=11 w=15, f=27 e=1 d=0 >2012-11-09 06:00:40.205+00005683: debug : virEventPollCalculateTimeout:320 : Calculate expiry of 6 timers >2012-11-09 06:00:40.205+00005683: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1352440843209 >2012-11-09 06:00:40.205+00005683: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1352440844024 >2012-11-09 06:00:40.205+00005683: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1352440845198 >2012-11-09 06:00:40.205+00005683: debug : virEventPollCalculateTimeout:346 : Timeout at 1352440843209 due in 3004 ms >2012-11-09 06:00:40.205+00005683: debug : virEventPollRunOnce:614 : EVENT_POLL_RUN: nhandles=12 timeout=3004 >2012-11-09 06:00:40.205+00005683: debug : virEventPollRunOnce:625 : Poll got 1 event(s) >2012-11-09 06:00:40.205+00005683: debug : virEventPollDispatchTimeouts:410 : Dispatch 6 >2012-11-09 06:00:40.205+00005683: debug : virEventPollDispatchHandles:455 : Dispatch 12 >2012-11-09 06:00:40.205+00005683: debug : virEventPollDispatchHandles:469 : i=0 w=1 >2012-11-09 06:00:40.205+00005683: debug : virEventPollDispatchHandles:469 : i=1 w=2 >2012-11-09 06:00:40.205+00005683: debug : virEventPollDispatchHandles:469 : i=2 w=3 >2012-11-09 06:00:40.205+00005683: debug : virEventPollDispatchHandles:469 : i=3 w=4 >2012-11-09 06:00:40.205+00005683: debug : virEventPollDispatchHandles:469 : i=4 w=5 >2012-11-09 06:00:40.205+00005683: debug : virEventPollDispatchHandles:469 : i=5 w=6 >2012-11-09 06:00:40.205+00005683: debug : virEventPollDispatchHandles:469 : i=6 w=7 >2012-11-09 06:00:40.205+00005683: debug : virEventPollDispatchHandles:469 : i=7 w=10 >2012-11-09 06:00:40.205+00005683: debug : virEventPollDispatchHandles:469 : i=8 w=11 >2012-11-09 06:00:40.205+00005683: debug : virEventPollDispatchHandles:469 : i=9 w=13 >2012-11-09 06:00:40.205+00005683: debug : virEventPollDispatchHandles:469 : i=10 w=14 >2012-11-09 06:00:40.205+00005683: debug : virEventPollDispatchHandles:469 : i=11 w=15 >2012-11-09 06:00:40.205+00005683: debug : virEventPollDispatchHandles:483 : EVENT_POLL_DISPATCH_HANDLE: watch=15 events=1 >2012-11-09 06:00:40.205+00005683: debug : virNetMessageDecodeLength:152 : Got length, now need 28 total (24 more) >2012-11-09 06:00:40.205+00005683: debug : virNetServerClientCalculateHandleMode:152 : tls=(nil) hs=-1, rx=0x12e6b80 tx=(nil) >2012-11-09 06:00:40.205+00005683: debug : virNetServerClientCalculateHandleMode:183 : mode=1 >2012-11-09 06:00:40.205+00005683: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=15 events=1 >2012-11-09 06:00:40.205+00005683: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 603646048 >2012-11-09 06:00:40.205+00005683: debug : virNetServerClientDispatchRead:872 : RPC_SERVER_CLIENT_MSG_RX: client=0x12e8cc0 len=28 prog=536903814 vers=1 proc=110 type=0 status=0 serial=3 >2012-11-09 06:00:40.205+00005683: debug : virKeepAliveCheckMessage:384 : ka=0x12e6fe0, client=0x12e8cc0, msg=0x12e6b80 >2012-11-09 06:00:40.205+00005683: debug : virEventPollUpdateTimeout:254 : EVENT_POLL_UPDATE_TIMEOUT: timer=13 frequency=5000 >2012-11-09 06:00:40.205+00005683: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 603646048 >2012-11-09 06:00:40.205+00005683: debug : virObjectRef:168 : OBJECT_REF: obj=0x12e8cc0 >2012-11-09 06:00:40.205+00005683: debug : virNetServerDispatchNewMessage:218 : server=0x12ded20 client=0x12e8cc0 message=0x12e6b80 >2012-11-09 06:00:40.205+00005683: debug : virObjectRef:168 : OBJECT_REF: obj=0x12e9fd0 >2012-11-09 06:00:40.205+00005683: debug : virNetMessageNew:45 : msg=0x12e6c60 tracked=1 >2012-11-09 06:00:40.205+00005683: debug : virNetServerClientCalculateHandleMode:152 : tls=(nil) hs=-1, rx=0x12e6c60 tx=(nil) >2012-11-09 06:00:40.205+00005684: debug : virNetServerHandleJob:189 : server=0x12ded20 client=0x12e8cc0 message=0x12e6b80 prog=0x12e9fd0 >2012-11-09 06:00:40.205+00005683: debug : virNetServerClientCalculateHandleMode:183 : mode=1 >2012-11-09 06:00:40.205+00005683: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=15 events=1 >2012-11-09 06:00:40.205+00005684: debug : virNetServerProgramDispatch:284 : prog=536903814 ver=1 type=0 status=0 serial=3 proc=110 >2012-11-09 06:00:40.205+00005683: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 603646048 >2012-11-09 06:00:40.205+00005683: debug : virEventPollCleanupTimeouts:501 : Cleanup 6 >2012-11-09 06:00:40.205+00005683: debug : virEventPollCleanupHandles:549 : Cleanup 12 >2012-11-09 06:00:40.205+00005683: debug : virEventRunDefaultImpl:244 : running default event implementation >2012-11-09 06:00:40.205+00005684: debug : remoteDispatchGetURIHelper:7297 : server=0x12ded20 client=0x12e8cc0 msg=0x12e6b80 rerr=0x7f3b1e11bb80 args=0x7f3b10169c00 ret=0x7f3b100d6700 >2012-11-09 06:00:40.205+00005683: debug : virEventPollCleanupTimeouts:501 : Cleanup 6 >2012-11-09 06:00:40.205+00005684: debug : virConnectGetURI:1700 : conn=0x7f3af0181df0 >2012-11-09 06:00:40.205+00005683: debug : virEventPollCleanupHandles:549 : Cleanup 12 >2012-11-09 06:00:40.205+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=0 w=1, f=7 e=1 d=0 >2012-11-09 06:00:40.205+00005684: debug : virNetMessageEncodePayload:358 : Encode length as 48 >2012-11-09 06:00:40.205+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=1 w=2, f=9 e=1 d=0 >2012-11-09 06:00:40.205+00005684: debug : virNetServerClientSendMessageLocked:1116 : msg=0x12e6b80 proc=110 len=48 offset=0 >2012-11-09 06:00:40.205+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=2 w=3, f=12 e=1 d=0 >2012-11-09 06:00:40.205+00005684: debug : virNetServerClientSendMessageLocked:1124 : RPC_SERVER_CLIENT_MSG_TX_QUEUE: client=0x12e8cc0 len=48 prog=536903814 vers=1 proc=110 type=1 status=0 serial=3 >2012-11-09 06:00:40.205+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=3 w=4, f=13 e=1 d=0 >2012-11-09 06:00:40.205+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=4 w=5, f=14 e=1 d=0 >2012-11-09 06:00:40.205+00005684: debug : virNetServerClientCalculateHandleMode:152 : tls=(nil) hs=-1, rx=0x12e6c60 tx=0x12e6b80 >2012-11-09 06:00:40.205+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=5 w=6, f=16 e=1 d=0 >2012-11-09 06:00:40.205+00005684: debug : virNetServerClientCalculateHandleMode:183 : mode=3 >2012-11-09 06:00:40.205+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=6 w=7, f=17 e=1 d=0 >2012-11-09 06:00:40.205+00005684: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=15 events=3 >2012-11-09 06:00:40.205+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=7 w=10, f=24 e=25 d=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=8 w=11, f=23 e=25 d=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=9 w=13, f=22 e=1 d=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=10 w=14, f=19 e=1 d=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=11 w=15, f=27 e=1 d=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollCalculateTimeout:320 : Calculate expiry of 6 timers >2012-11-09 06:00:40.206+00005683: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1352440843209 >2012-11-09 06:00:40.206+00005683: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1352440844024 >2012-11-09 06:00:40.206+00005683: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1352440845205 >2012-11-09 06:00:40.206+00005683: debug : virEventPollCalculateTimeout:346 : Timeout at 1352440843209 due in 3003 ms >2012-11-09 06:00:40.206+00005683: debug : virEventPollRunOnce:614 : EVENT_POLL_RUN: nhandles=12 timeout=3003 >2012-11-09 06:00:40.206+00005684: debug : virEventPollInterruptLocked:701 : Interrupting >2012-11-09 06:00:40.206+00005684: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x12e9fd0 >2012-11-09 06:00:40.206+00005684: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x12e8cc0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollRunOnce:625 : Poll got 1 event(s) >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchTimeouts:410 : Dispatch 6 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:455 : Dispatch 12 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=0 w=1 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:483 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=1 w=2 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=2 w=3 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=3 w=4 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=4 w=5 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=5 w=6 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=6 w=7 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=7 w=10 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=8 w=11 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=9 w=13 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=10 w=14 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=11 w=15 >2012-11-09 06:00:40.206+00005683: debug : virEventPollCleanupTimeouts:501 : Cleanup 6 >2012-11-09 06:00:40.206+00005683: debug : virEventPollCleanupHandles:549 : Cleanup 12 >2012-11-09 06:00:40.206+00005683: debug : virEventRunDefaultImpl:244 : running default event implementation >2012-11-09 06:00:40.206+00005683: debug : virEventPollCleanupTimeouts:501 : Cleanup 6 >2012-11-09 06:00:40.206+00005683: debug : virEventPollCleanupHandles:549 : Cleanup 12 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=0 w=1, f=7 e=1 d=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=1 w=2, f=9 e=1 d=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=2 w=3, f=12 e=1 d=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=3 w=4, f=13 e=1 d=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=4 w=5, f=14 e=1 d=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=5 w=6, f=16 e=1 d=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=6 w=7, f=17 e=1 d=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=7 w=10, f=24 e=25 d=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=8 w=11, f=23 e=25 d=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=9 w=13, f=22 e=1 d=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=10 w=14, f=19 e=1 d=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=11 w=15, f=27 e=5 d=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollCalculateTimeout:320 : Calculate expiry of 6 timers >2012-11-09 06:00:40.206+00005683: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1352440843209 >2012-11-09 06:00:40.206+00005683: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1352440844024 >2012-11-09 06:00:40.206+00005683: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1352440845205 >2012-11-09 06:00:40.206+00005683: debug : virEventPollCalculateTimeout:346 : Timeout at 1352440843209 due in 3003 ms >2012-11-09 06:00:40.206+00005683: debug : virEventPollRunOnce:614 : EVENT_POLL_RUN: nhandles=12 timeout=3003 >2012-11-09 06:00:40.206+00005683: debug : virEventPollRunOnce:625 : Poll got 1 event(s) >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchTimeouts:410 : Dispatch 6 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:455 : Dispatch 12 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=0 w=1 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=1 w=2 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=2 w=3 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=3 w=4 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=4 w=5 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=5 w=6 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=6 w=7 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=7 w=10 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=8 w=11 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=9 w=13 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=10 w=14 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=11 w=15 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:483 : EVENT_POLL_DISPATCH_HANDLE: watch=15 events=2 >2012-11-09 06:00:40.206+00005683: debug : virNetMessageFree:73 : msg=0x12e6b80 nfds=0 cb=(nil) >2012-11-09 06:00:40.206+00005683: debug : virNetServerClientCalculateHandleMode:152 : tls=(nil) hs=-1, rx=0x12e6c60 tx=(nil) >2012-11-09 06:00:40.206+00005683: debug : virNetServerClientCalculateHandleMode:183 : mode=1 >2012-11-09 06:00:40.206+00005683: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=15 events=1 >2012-11-09 06:00:40.206+00005683: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 603646048 >2012-11-09 06:00:40.206+00005683: debug : virEventPollCleanupTimeouts:501 : Cleanup 6 >2012-11-09 06:00:40.206+00005683: debug : virEventPollCleanupHandles:549 : Cleanup 12 >2012-11-09 06:00:40.206+00005683: debug : virEventRunDefaultImpl:244 : running default event implementation >2012-11-09 06:00:40.206+00005683: debug : virEventPollCleanupTimeouts:501 : Cleanup 6 >2012-11-09 06:00:40.206+00005683: debug : virEventPollCleanupHandles:549 : Cleanup 12 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=0 w=1, f=7 e=1 d=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=1 w=2, f=9 e=1 d=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=2 w=3, f=12 e=1 d=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=3 w=4, f=13 e=1 d=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=4 w=5, f=14 e=1 d=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=5 w=6, f=16 e=1 d=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=6 w=7, f=17 e=1 d=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=7 w=10, f=24 e=25 d=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=8 w=11, f=23 e=25 d=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=9 w=13, f=22 e=1 d=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=10 w=14, f=19 e=1 d=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=11 w=15, f=27 e=1 d=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollCalculateTimeout:320 : Calculate expiry of 6 timers >2012-11-09 06:00:40.206+00005683: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1352440843209 >2012-11-09 06:00:40.206+00005683: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1352440844024 >2012-11-09 06:00:40.206+00005683: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1352440845205 >2012-11-09 06:00:40.206+00005683: debug : virEventPollCalculateTimeout:346 : Timeout at 1352440843209 due in 3003 ms >2012-11-09 06:00:40.206+00005683: debug : virEventPollRunOnce:614 : EVENT_POLL_RUN: nhandles=12 timeout=3003 >2012-11-09 06:00:40.206+00005683: debug : virEventPollRunOnce:625 : Poll got 1 event(s) >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchTimeouts:410 : Dispatch 6 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:455 : Dispatch 12 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=0 w=1 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=1 w=2 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=2 w=3 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=3 w=4 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=4 w=5 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=5 w=6 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=6 w=7 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=7 w=10 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=8 w=11 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=9 w=13 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=10 w=14 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=11 w=15 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:483 : EVENT_POLL_DISPATCH_HANDLE: watch=15 events=1 >2012-11-09 06:00:40.206+00005683: debug : virNetMessageDecodeLength:152 : Got length, now need 36 total (32 more) >2012-11-09 06:00:40.206+00005683: debug : virNetServerClientCalculateHandleMode:152 : tls=(nil) hs=-1, rx=0x12e6c60 tx=(nil) >2012-11-09 06:00:40.206+00005683: debug : virNetServerClientCalculateHandleMode:183 : mode=1 >2012-11-09 06:00:40.206+00005683: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=15 events=1 >2012-11-09 06:00:40.206+00005683: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 603646048 >2012-11-09 06:00:40.206+00005683: debug : virNetServerClientDispatchRead:872 : RPC_SERVER_CLIENT_MSG_RX: client=0x12e8cc0 len=36 prog=536903814 vers=1 proc=23 type=0 status=0 serial=4 >2012-11-09 06:00:40.206+00005683: debug : virKeepAliveCheckMessage:384 : ka=0x12e6fe0, client=0x12e8cc0, msg=0x12e6c60 >2012-11-09 06:00:40.206+00005683: debug : virEventPollUpdateTimeout:254 : EVENT_POLL_UPDATE_TIMEOUT: timer=13 frequency=5000 >2012-11-09 06:00:40.206+00005683: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 603646048 >2012-11-09 06:00:40.206+00005683: debug : virObjectRef:168 : OBJECT_REF: obj=0x12e8cc0 >2012-11-09 06:00:40.206+00005683: debug : virNetServerDispatchNewMessage:218 : server=0x12ded20 client=0x12e8cc0 message=0x12e6c60 >2012-11-09 06:00:40.206+00005683: debug : virObjectRef:168 : OBJECT_REF: obj=0x12e9fd0 >2012-11-09 06:00:40.206+00005683: debug : virNetMessageNew:45 : msg=0x12e85d0 tracked=1 >2012-11-09 06:00:40.206+00005683: debug : virNetServerClientCalculateHandleMode:152 : tls=(nil) hs=-1, rx=0x12e85d0 tx=(nil) >2012-11-09 06:00:40.206+00005683: debug : virNetServerClientCalculateHandleMode:183 : mode=1 >2012-11-09 06:00:40.206+00005692: debug : virNetServerHandleJob:189 : server=0x12ded20 client=0x12e8cc0 message=0x12e6c60 prog=0x12e9fd0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=15 events=1 >2012-11-09 06:00:40.206+00005683: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 603646048 >2012-11-09 06:00:40.206+00005692: debug : virNetServerProgramDispatch:284 : prog=536903814 ver=1 type=0 status=0 serial=4 proc=23 >2012-11-09 06:00:40.206+00005683: debug : virEventPollCleanupTimeouts:501 : Cleanup 6 >2012-11-09 06:00:40.206+00005683: debug : virEventPollCleanupHandles:549 : Cleanup 12 >2012-11-09 06:00:40.206+00005692: debug : remoteDispatchDomainLookupByNameHelper:3084 : server=0x12ded20 client=0x12e8cc0 msg=0x12e6c60 rerr=0x7f3b19113b80 args=0x7f3af40009a0 ret=0x7f3af4000ce0 >2012-11-09 06:00:40.206+00005683: debug : virEventRunDefaultImpl:244 : running default event implementation >2012-11-09 06:00:40.206+00005692: debug : virDomainLookupByName:2117 : conn=0x7f3af0181df0, name=test >2012-11-09 06:00:40.206+00005683: debug : virEventPollCleanupTimeouts:501 : Cleanup 6 >2012-11-09 06:00:40.206+00005683: debug : virEventPollCleanupHandles:549 : Cleanup 12 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=0 w=1, f=7 e=1 d=0 >2012-11-09 06:00:40.206+00005692: debug : virObjectNew:110 : OBJECT_NEW: obj=0x7f3af4000ca0 classname=virDomain >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=1 w=2, f=9 e=1 d=0 >2012-11-09 06:00:40.206+00005692: debug : virObjectRef:168 : OBJECT_REF: obj=0x7f3af0181df0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=2 w=3, f=12 e=1 d=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=3 w=4, f=13 e=1 d=0 >2012-11-09 06:00:40.206+00005692: debug : virDomainFree:2281 : dom=0x7f3af4000ca0, (VM: name=test, uuid=aa5d3f4d-ac22-c76a-aa95-53bfb224f47a) >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=4 w=5, f=14 e=1 d=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=5 w=6, f=16 e=1 d=0 >2012-11-09 06:00:40.206+00005692: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7f3af4000ca0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=6 w=7, f=17 e=1 d=0 >2012-11-09 06:00:40.206+00005692: debug : virObjectUnref:137 : OBJECT_DISPOSE: obj=0x7f3af4000ca0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=7 w=10, f=24 e=25 d=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=8 w=11, f=23 e=25 d=0 >2012-11-09 06:00:40.206+00005692: debug : virDomainDispose:225 : release domain 0x7f3af4000ca0 test aa5d3f4d-ac22-c76a-aa95-53bfb224f47a >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=9 w=13, f=22 e=1 d=0 >2012-11-09 06:00:40.206+00005692: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7f3af0181df0 >2012-11-09 06:00:40.206+00005692: debug : virNetMessageEncodePayload:358 : Encode length as 56 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=10 w=14, f=19 e=1 d=0 >2012-11-09 06:00:40.206+00005692: debug : virNetServerClientSendMessageLocked:1116 : msg=0x12e6c60 proc=23 len=56 offset=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=11 w=15, f=27 e=1 d=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollCalculateTimeout:320 : Calculate expiry of 6 timers >2012-11-09 06:00:40.206+00005692: debug : virNetServerClientSendMessageLocked:1124 : RPC_SERVER_CLIENT_MSG_TX_QUEUE: client=0x12e8cc0 len=56 prog=536903814 vers=1 proc=23 type=1 status=0 serial=4 >2012-11-09 06:00:40.206+00005683: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1352440843209 >2012-11-09 06:00:40.206+00005692: debug : virNetServerClientCalculateHandleMode:152 : tls=(nil) hs=-1, rx=0x12e85d0 tx=0x12e6c60 >2012-11-09 06:00:40.206+00005683: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1352440844024 >2012-11-09 06:00:40.206+00005692: debug : virNetServerClientCalculateHandleMode:183 : mode=3 >2012-11-09 06:00:40.206+00005683: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1352440845206 >2012-11-09 06:00:40.206+00005692: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=15 events=3 >2012-11-09 06:00:40.206+00005683: debug : virEventPollCalculateTimeout:346 : Timeout at 1352440843209 due in 3003 ms >2012-11-09 06:00:40.206+00005683: debug : virEventPollRunOnce:614 : EVENT_POLL_RUN: nhandles=12 timeout=3003 >2012-11-09 06:00:40.206+00005692: debug : virEventPollInterruptLocked:701 : Interrupting >2012-11-09 06:00:40.206+00005692: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x12e9fd0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollRunOnce:625 : Poll got 1 event(s) >2012-11-09 06:00:40.206+00005692: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x12e8cc0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchTimeouts:410 : Dispatch 6 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:455 : Dispatch 12 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=0 w=1 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:483 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=1 w=2 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=2 w=3 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=3 w=4 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=4 w=5 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=5 w=6 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=6 w=7 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=7 w=10 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=8 w=11 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=9 w=13 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=10 w=14 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=11 w=15 >2012-11-09 06:00:40.206+00005683: debug : virEventPollCleanupTimeouts:501 : Cleanup 6 >2012-11-09 06:00:40.206+00005683: debug : virEventPollCleanupHandles:549 : Cleanup 12 >2012-11-09 06:00:40.206+00005683: debug : virEventRunDefaultImpl:244 : running default event implementation >2012-11-09 06:00:40.206+00005683: debug : virEventPollCleanupTimeouts:501 : Cleanup 6 >2012-11-09 06:00:40.206+00005683: debug : virEventPollCleanupHandles:549 : Cleanup 12 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=0 w=1, f=7 e=1 d=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=1 w=2, f=9 e=1 d=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=2 w=3, f=12 e=1 d=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=3 w=4, f=13 e=1 d=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=4 w=5, f=14 e=1 d=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=5 w=6, f=16 e=1 d=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=6 w=7, f=17 e=1 d=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=7 w=10, f=24 e=25 d=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=8 w=11, f=23 e=25 d=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=9 w=13, f=22 e=1 d=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=10 w=14, f=19 e=1 d=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=11 w=15, f=27 e=5 d=0 >2012-11-09 06:00:40.206+00005683: debug : virEventPollCalculateTimeout:320 : Calculate expiry of 6 timers >2012-11-09 06:00:40.206+00005683: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1352440843209 >2012-11-09 06:00:40.206+00005683: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1352440844024 >2012-11-09 06:00:40.206+00005683: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1352440845206 >2012-11-09 06:00:40.206+00005683: debug : virEventPollCalculateTimeout:346 : Timeout at 1352440843209 due in 3003 ms >2012-11-09 06:00:40.206+00005683: debug : virEventPollRunOnce:614 : EVENT_POLL_RUN: nhandles=12 timeout=3003 >2012-11-09 06:00:40.206+00005683: debug : virEventPollRunOnce:625 : Poll got 1 event(s) >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchTimeouts:410 : Dispatch 6 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:455 : Dispatch 12 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=0 w=1 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=1 w=2 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=2 w=3 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=3 w=4 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=4 w=5 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=5 w=6 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=6 w=7 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=7 w=10 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=8 w=11 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=9 w=13 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=10 w=14 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:469 : i=11 w=15 >2012-11-09 06:00:40.206+00005683: debug : virEventPollDispatchHandles:483 : EVENT_POLL_DISPATCH_HANDLE: watch=15 events=2 >2012-11-09 06:00:40.206+00005683: debug : virNetMessageFree:73 : msg=0x12e6c60 nfds=0 cb=(nil) >2012-11-09 06:00:40.206+00005683: debug : virNetServerClientCalculateHandleMode:152 : tls=(nil) hs=-1, rx=0x12e85d0 tx=(nil) >2012-11-09 06:00:40.206+00005683: debug : virNetServerClientCalculateHandleMode:183 : mode=1 >2012-11-09 06:00:40.206+00005683: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=15 events=1 >2012-11-09 06:00:40.206+00005683: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 603646048 >2012-11-09 06:00:40.206+00005683: debug : virEventPollCleanupTimeouts:501 : Cleanup 6 >2012-11-09 06:00:40.206+00005683: debug : virEventPollCleanupHandles:549 : Cleanup 12 >2012-11-09 06:00:40.206+00005683: debug : virEventRunDefaultImpl:244 : running default event implementation >2012-11-09 06:00:40.206+00005683: debug : virEventPollCleanupTimeouts:501 : Cleanup 6 >2012-11-09 06:00:40.207+00005683: debug : virEventPollCleanupHandles:549 : Cleanup 12 >2012-11-09 06:00:40.207+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=0 w=1, f=7 e=1 d=0 >2012-11-09 06:00:40.207+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=1 w=2, f=9 e=1 d2012-11-09 06:00:40.679+00005686: debug : virNetServerProgramSendError:150 : prog=536903814 ver=1 proc=261 type=1 serial=5 msg=0x12e7860 rerr=0x7f3b1cd19b80 >2012-11-09 06:00:40.679+00005686: debug : virNetMessageEncodePayload:358 : Encode length as 168 >2012-11-09 06:00:40.679+00005686: debug : virNetServerClientSendMessageLocked:1116 : msg=0x12e7860 proc=261 len=168 offset=0 >2012-11-09 06:00:40.679+00005686: debug : virNetServerClientSendMessageLocked:1124 : RPC_SERVER_CLIENT_MSG_TX_QUEUE: client=0x12e7ca0 len=168 prog=536903814 vers=1 proc=261 type=1 status=1 serial=5 >2012-11-09 06:00:40.679+00005686: debug : virNetServerClientCalculateHandleMode:152 : tls=(nil) hs=-1, rx=0x12e7d80 tx=0x12e7860 >2012-11-09 06:00:40.679+00005686: debug : virNetServerClientCalculateHandleMode:183 : mode=3 >2012-11-09 06:00:40.679+00005686: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=13 events=3 >2012-11-09 06:00:40.679+00005686: debug : virEventPollInterruptLocked:701 : Interrupting >2012-11-09 06:00:40.679+00005686: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x12e9fd0 >2012-11-09 06:00:40.679+00005686: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x12e7ca0 >tPollCalculateTimeout:326 : Got a timeout scheduled for 1352440843209 >2012-11-09 06:00:40.207+00005683: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1352440844024 >2012-11-09 06:00:40.207+00005683: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1352440845206 >2012-11-09 06:00:40.207+00005683: debug : virEventPollCalculateTimeout:346 : Timeout at 1352440843209 due in 3002 ms >2012-11-09 06:00:40.207+00005683: debug : virEventPollRunOnce:614 : EVENT_POLL_RUN: nhandles=12 timeout=3002 >2012-11-09 06:00:40.207+00005683: debug : virEventPollRunOnce:625 : Poll got 1 event(s) >2012-11-09 06:00:40.207+00005683: debug : virEventPollDispatchTimeouts:410 : Dispatch 6 >2012-11-09 06:00:40.207+00005683: debug : virEventPollDispatchHandles:455 : Dispatch 12 >2012-11-09 06:00:40.207+00005683: debug : virEventPollDispatchHandles:469 : i=0 w=1 >2012-11-09 06:00:40.207+00005683: debug : virEventPollDispatchHandles:469 : i=1 w=2 >2012-11-09 06:00:40.207+00005683: debug : virEventPollDispatchHandles:469 : i=2 w=3 >2012-11-09 06:00:40.207+00005683: debug : virEventPollDispatchHandles:469 : i=3 w=4 >2012-11-09 06:00:40.207+00005683: debug : virEventPollDispatchHandles:469 : i=4 w=5 >2012-11-09 06:00:40.207+00005683: debug : virEventPollDispatchHandles:469 : i=5 w=6 >2012-11-09 06:00:40.207+00005683: debug : virEventPollDispatchHandles:469 : i=6 w=7 >2012-11-09 06:00:40.207+00005683: debug : virEventPollDispatchHandles:469 : i=7 w=10 >2012-11-09 06:00:40.207+00005683: debug : virEventPollDispatchHandles:469 : i=8 w=11 >2012-11-09 06:00:40.207+00005683: debug : virEventPollDispatchHandles:469 : i=9 w=13 >2012-11-09 06:00:40.207+00005683: debug : virEventPollDispatchHandles:469 : i=10 w=14 >2012-11-09 06:00:40.207+00005683: debug : virEventPollDispatchHandles:469 : i=11 w=15 >2012-11-09 06:00:40.207+00005683: debug : virEventPollDispatchHandles:483 : EVENT_POLL_DISPATCH_HANDLE: watch=15 events=1 >2012-11-09 06:00:40.207+00005683: debug : virNetMessageDecodeLength:152 : Got length, now need 56 total (52 more) >2012-11-09 06:00:40.207+00005683: debug : virNetServerClientCalculateHandleMode:152 : tls=(nil) hs=-1, rx=0x12e85d0 tx=(nil) >2012-11-09 06:00:40.207+00005683: debug : virNetServerClientCalculateHandleMode:183 : mode=1 >2012-11-09 06:00:40.207+00005683: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=15 events=1 >2012-11-09 06:00:40.207+00005683: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 603646048 >2012-11-09 06:00:40.207+00005683: debug : virNetServerClientDispatchRead:872 : RPC_SERVER_CLIENT_MSG_RX: client=0x12e8cc0 len=56 prog=536903814 vers=1 proc=12 type=0 status=0 serial=5 >2012-11-09 06:00:40.207+00005683: debug : virKeepAliveCheckMessage:384 : ka=0x12e6fe0, client=0x12e8cc0, msg=0x12e85d0 >2012-11-09 06:00:40.207+00005683: debug : virEventPollUpdateTimeout:254 : EVENT_POLL_UPDATE_TIMEOUT: timer=13 frequency=5000 >2012-11-09 06:00:40.207+00005683: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 603646048 >2012-11-09 06:00:40.207+00005683: debug : virObjectRef:168 : OBJECT_REF: obj=0x12e8cc0 >2012-11-09 06:00:40.207+00005683: debug : virNetServerDispatchNewMessage:218 : server=0x12ded20 client=0x12e8cc0 message=0x12e85d0 >2012-11-09 06:00:40.207+00005683: debug : virObjectRef:168 : OBJECT_REF: obj=0x12e9fd0 >2012-11-09 06:00:40.207+00005683: debug : virNetMessageNew:45 : msg=0x12e80b0 tracked=1 >2012-11-09 06:00:40.207+00005683: debug : virNetServerClientCalculateHandleMode:152 : tls=(nil) hs=-1, rx=0x12e80b0 tx=(nil) >2012-11-09 06:00:40.207+00005693: debug : virNetServerHandleJob:189 : server=0x12ded20 client=0x12e8cc0 message=0x12e85d0 prog=0x12e9fd0 >2012-11-09 06:00:40.207+00005683: debug : virNetServerClientCalculateHandleMode:183 : mode=1 >2012-11-09 06:00:40.207+00005683: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=15 events=1 >2012-11-09 06:00:40.207+00005693: debug : virNetServerProgramDispatch:284 : prog=536903814 ver=1 type=0 status=0 serial=5 proc=12 >2012-11-09 06:00:40.207+00005683: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 603646048 >2012-11-09 06:00:40.207+00005683: debug : virEventPollCleanupTimeouts:501 : Cleanup 6 >2012-11-09 06:00:40.207+00005683: debug : virEventPollCleanupHandles:549 : Cleanup 12 >2012-11-09 06:00:40.207+00005683: debug : virEventRunDefaultImpl:244 : running default event implementation >2012-11-09 06:00:40.207+00005693: debug : remoteDispatchDomainDestroyHelper:1254 : server=0x12ded20 client=0x12e8cc0 msg=0x12e85d0 rerr=0x7f3b18712b80 args=0x7f3afc000c40 ret=0x7f3afc0008c0 >2012-11-09 06:00:40.207+00005683: debug : virEventPollCleanupTimeouts:501 : Cleanup 6 >2012-11-09 06:00:40.207+00005693: debug : virObjectNew:110 : OBJECT_NEW: obj=0x7f3afc000c00 classname=virDomain >2012-11-09 06:00:40.207+00005683: debug : virEventPollCleanupHandles:549 : Cleanup 12 >2012-11-09 06:00:40.207+00005693: debug : virObjectRef:168 : OBJECT_REF: obj=0x7f3af0181df0 >2012-11-09 06:00:40.207+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=0 w=1, f=7 e=1 d=0 >2012-11-09 06:00:40.207+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=1 w=2, f=9 e=1 d=0 >2012-11-09 06:00:40.207+00005693: debug : virDomainDestroy:2172 : dom=0x7f3afc000c00, (VM: name=test, uuid=aa5d3f4d-ac22-c76a-aa95-53bfb224f47a) >2012-11-09 06:00:40.207+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=2 w=3, f=12 e=1 d=0 >2012-11-09 06:00:40.207+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=3 w=4, f=13 e=1 d=0 >2012-11-09 06:00:40.207+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=4 w=5, f=14 e=1 d=0 >2012-11-09 06:00:40.207+00005693: debug : qemuProcessKill:3959 : vm=test pid=5784 flags=1 >2012-11-09 06:00:40.207+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=5 w=6, f=16 e=1 d=0 >2012-11-09 06:00:40.207+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=6 w=7, f=17 e=1 d=0 >2012-11-09 06:00:40.207+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=7 w=10, f=24 e=25 d=0 >2012-11-09 06:00:40.207+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=8 w=11, f=23 e=25 d=0 >2012-11-09 06:00:40.207+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=9 w=13, f=22 e=1 d=0 >2012-11-09 06:00:40.207+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=10 w=14, f=19 e=1 d=0 >2012-11-09 06:00:40.207+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=11 w=15, f=27 e=1 d=0 >2012-11-09 06:00:40.207+00005683: debug : virEventPollCalculateTimeout:320 : Calculate expiry of 6 timers >2012-11-09 06:00:40.207+00005683: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1352440843209 >2012-11-09 06:00:40.207+00005683: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1352440844024 >2012-11-09 06:00:40.207+00005683: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1352440845207 >2012-11-09 06:00:40.207+00005683: debug : virEventPollCalculateTimeout:346 : Timeout at 1352440843209 due in 3002 ms >2012-11-09 06:00:40.207+00005683: debug : virEventPollRunOnce:614 : EVENT_POLL_RUN: nhandles=12 timeout=3002 >2012-11-09 06:00:40.207+00005683: debug : virEventPollRunOnce:625 : Poll got 1 event(s) >2012-11-09 06:00:40.207+00005683: debug : virEventPollDispatchTimeouts:410 : Dispatch 6 >2012-11-09 06:00:40.207+00005683: debug : virEventPollDispatchHandles:455 : Dispatch 12 >2012-11-09 06:00:40.207+00005683: debug : virEventPollDispatchHandles:469 : i=0 w=1 >2012-11-09 06:00:40.207+00005683: debug : virEventPollDispatchHandles:469 : i=1 w=2 >2012-11-09 06:00:40.207+00005683: debug : virEventPollDispatchHandles:469 : i=2 w=3 >2012-11-09 06:00:40.207+00005683: debug : virEventPollDispatchHandles:469 : i=3 w=4 >2012-11-09 06:00:40.207+00005683: debug : virEventPollDispatchHandles:469 : i=4 w=5 >2012-11-09 06:00:40.207+00005683: debug : virEventPollDispatchHandles:469 : i=5 w=6 >2012-11-09 06:00:40.207+00005683: debug : virEventPollDispatchHandles:469 : i=6 w=7 >2012-11-09 06:00:40.207+00005683: debug : virEventPollDispatchHandles:469 : i=7 w=10 >2012-11-09 06:00:40.207+00005683: debug : virEventPollDispatchHandles:483 : EVENT_POLL_DISPATCH_HANDLE: watch=10 events=1 >2012-11-09 06:00:40.207+00005683: debug : virObjectRef:168 : OBJECT_REF: obj=0x7f3b08003230 >2012-11-09 06:00:40.207+00005683: debug : qemuMonitorIOProcess:353 : QEMU_MONITOR_IO_PROCESS: mon=0x7f3b08003230 buf={"timestamp": {"seconds": 1352440840, "microseconds": 207686}, "event": "SHUTDOWN"} > len=85 >2012-11-09 06:00:40.207+00005683: debug : qemuMonitorJSONIOProcessLine:150 : Line [{"timestamp": {"seconds": 1352440840, "microseconds": 207686}, "event": "SHUTDOWN"}] >2012-11-09 06:00:40.207+00005683: debug : virJSONValueFromString:975 : string={"timestamp": {"seconds": 1352440840, "microseconds": 207686}, "event": "SHUTDOWN"} >2012-11-09 06:00:40.207+00005683: debug : virJSONParserHandleStartMap:852 : parser=0x7fffd9282a20 >2012-11-09 06:00:40.207+00005683: debug : virJSONParserHandleMapKey:833 : parser=0x7fffd9282a20 key=0x12e74c2 >2012-11-09 06:00:40.207+00005683: debug : virJSONParserHandleStartMap:852 : parser=0x7fffd9282a20 >2012-11-09 06:00:40.207+00005683: debug : virJSONParserHandleMapKey:833 : parser=0x7fffd9282a20 key=0x12e74d0 >2012-11-09 06:00:40.207+00005683: debug : virJSONParserHandleNumber:792 : parser=0x7fffd9282a20 str=(null) >2012-11-09 06:00:40.207+00005683: debug : virJSONParserHandleMapKey:833 : parser=0x7fffd9282a20 key=0x12e74e7 >2012-11-09 06:00:40.207+00005683: debug : virJSONParserHandleNumber:792 : parser=0x7fffd9282a20 str=(null) >2012-11-09 06:00:40.207+00005683: debug : virJSONParserHandleEndMap:881 : parser=0x7fffd9282a20 >2012-11-09 06:00:40.207+00005683: debug : virJSONParserHandleMapKey:833 : parser=0x7fffd9282a20 key=0x12e7500 >2012-11-09 06:00:40.207+00005683: debug : virJSONParserHandleString:813 : parser=0x7fffd9282a20 str=0x12e7509 >2012-11-09 06:00:40.207+00005683: debug : virJSONParserHandleEndMap:881 : parser=0x7fffd9282a20 >2012-11-09 06:00:40.207+00005683: debug : virJSONValueFromString:1019 : result=0x12ca290 >2012-11-09 06:00:40.207+00005683: debug : qemuMonitorJSONIOProcessLine:165 : QEMU_MONITOR_RECV_EVENT: mon=0x7f3b08003230 event={"timestamp": {"seconds": 1352440840, "microseconds": 207686}, "event": "SHUTDOWN"} >2012-11-09 06:00:40.207+00005683: debug : qemuMonitorJSONIOProcessEvent:122 : mon=0x7f3b08003230 obj=0x12ca290 >2012-11-09 06:00:40.207+00005683: debug : qemuMonitorJSONIOProcessEvent:136 : handle SHUTDOWN handler=0x4b6400 data=(nil) >2012-11-09 06:00:40.207+00005683: debug : qemuMonitorEmitShutdown:987 : mon=0x7f3b08003230 >2012-11-09 06:00:40.207+00005683: debug : virObjectRef:168 : OBJECT_REF: obj=0x7f3b08003230 >2012-11-09 06:00:40.207+00005683: debug : qemuProcessHandleShutdown:637 : vm=0x7f3b1000d360 >2012-11-09 06:00:40.607+00005693: debug : virObjectRef:168 : OBJECT_REF: obj=0x7f3b1000d360 >2012-11-09 06:00:40.607+00005693: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7f3b1000d360 >2012-11-09 06:00:40.607+00005693: debug : virObjectRef:168 : OBJECT_REF: obj=0x7f3b1000d360 >2012-11-09 06:00:40.607+00005683: debug : qemuProcessHandleShutdown:654 : Transitioned guest test to shutdown state >2012-11-09 06:00:40.664+00005683: debug : virFileClose:72 : Closed fd 30 >2012-11-09 06:00:40.673+00005683: debug : qemuAgentNotifyEvent:1263 : mon=0x7f3b080033b0 event=1 >2012-11-09 06:00:40.673+00005683: warning : qemuAgentNotifyEvent:1274 : Received unexpected event 1 >2012-11-09 06:00:40.673+00005683: debug : qemuProcessKill:3959 : vm=test pid=5784 flags=2 >2012-11-09 06:00:40.673+00005683: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7f3b08003230 >2012-11-09 06:00:40.673+00005683: debug : qemuMonitorJSONIOProcess:221 : Total used 85 bytes out of 85 available in buffer >2012-11-09 06:00:40.673+00005683: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=10 events=13 >2012-11-09 06:00:40.673+00005683: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 603646048 >2012-11-09 06:00:40.673+00005683: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7f3b08003230 >2012-11-09 06:00:40.673+00005683: debug : virEventPollDispatchHandles:469 : i=8 w=11 >2012-11-09 06:00:40.673+00005683: debug : virEventPollDispatchHandles:469 : i=9 w=13 >2012-11-09 06:00:40.673+00005683: debug : virEventPollDispatchHandles:469 : i=10 w=14 >2012-11-09 06:00:40.673+00005683: debug : virEventPollDispatchHandles:469 : i=11 w=15 >2012-11-09 06:00:40.673+00005683: debug : virEventPollCleanupTimeouts:501 : Cleanup 6 >2012-11-09 06:00:40.673+00005683: debug : virEventPollCleanupHandles:549 : Cleanup 12 >2012-11-09 06:00:40.673+00005683: debug : virEventRunDefaultImpl:244 : running default event implementation >2012-11-09 06:00:40.673+00005683: debug : virEventPollCleanupTimeouts:501 : Cleanup 6 >2012-11-09 06:00:40.673+00005683: debug : virEventPollCleanupHandles:549 : Cleanup 12 >2012-11-09 06:00:40.673+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=0 w=1, f=7 e=1 d=0 >2012-11-09 06:00:40.673+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=1 w=2, f=9 e=1 d=0 >2012-11-09 06:00:40.673+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=2 w=3, f=12 e=1 d=0 >2012-11-09 06:00:40.673+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=3 w=4, f=13 e=1 d=0 >2012-11-09 06:00:40.673+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=4 w=5, f=14 e=1 d=0 >2012-11-09 06:00:40.673+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=5 w=6, f=16 e=1 d=0 >2012-11-09 06:00:40.673+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=6 w=7, f=17 e=1 d=0 >2012-11-09 06:00:40.673+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=7 w=10, f=24 e=25 d=0 >2012-11-09 06:00:40.673+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=8 w=11, f=23 e=25 d=0 >2012-11-09 06:00:40.673+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=9 w=13, f=22 e=1 d=0 >2012-11-09 06:00:40.673+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=10 w=14, f=19 e=1 d=0 >2012-11-09 06:00:40.673+00005683: debug : virEventPollMakePollFDs:378 : Prepare n=11 w=15, f=27 e=1 d=0 >2012-11-09 06:00:40.673+00005683: debug : virEventPollCalculateTimeout:320 : Calculate expiry of 6 timers >2012-11-09 06:00:40.673+00005683: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1352440843209 >2012-11-09 06:00:40.673+00005683: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1352440844024 >2012-11-09 06:00:40.673+00005683: debug : virEventPollCalculateTimeout:326 : Got a timeout scheduled for 1352440845207 >2012-11-09 06:00:40.673+00005683: debug : virEventPollCalculateTimeout:346 : Timeout at 1352440843209 due in 2536 ms >2012-11-09 06:00:40.673+00005683: debug : virEventPollRunOnce:614 : EVENT_POLL_RUN: nhandles=12 timeout=2536 >2012-11-09 06:00:40.673+00005683: debug : virEventPollRunOnce:625 : Poll got 4 event(s) >2012-11-09 06:00:40.673+00005683: debug : virEventPollDispatchTimeouts:410 : Dispatch 6 >2012-11-09 06:00:40.673+00005683: debug : virEventPollDispatchHandles:455 : Dispatch 12 >2012-11-09 06:00:40.673+00005683: debug : virEventPollDispatchHandles:469 : i=0 w=1 >2012-11-09 06:00:40.673+00005683: debug : virEventPollDispatchHandles:469 : i=1 w=2 >2012-11-09 06:00:40.673+00005683: debug : virEventPollDispatchHandles:469 : i=2 w=3 >2012-11-09 06:00:40.673+00005683: debug : virEventPollDispatchHandles:469 : i=3 w=4 >2012-11-09 06:00:40.673+00005683: debug : virEventPollDispatchHandles:469 : i=4 w=5 >2012-11-09 06:00:40.673+00005683: debug : virEventPollDispatchHandles:469 : i=5 w=6 >2012-11-09 06:00:40.673+00005683: debug : virEventPollDispatchHandles:483 : EVENT_POLL_DISPATCH_HANDLE: watch=6 events=1 >2012-11-09 06:00:40.679+00005683: debug : virNetlinkEventCallback:346 : dispatching to max 0 clients, called from event watch 6 >2012-11-09 06:00:40.679+00005683: debug : virNetlinkEventCallback:359 : event not handled. >2012-11-09 06:00:40.679+00005683: debug : virEventPollDispatchHandles:469 : i=6 w=7 >2012-11-09 06:00:40.679+00005683: debug : virEventPollDispatchHandles:483 : EVENT_POLL_DISPATCH_HANDLE: watch=7 events=1 >2012-11-09 06:00:40.679+00005683: debug : udevEventHandleCallback:1467 : udev action: 'remove' >2012-11-09 06:00:40.679+00005683: debug : udevRemoveOneDevice:1218 : Failed to find device to remove that has udev name '/sys/devices/virtual/net/vnet0/queues/tx-0' >2012-11-09 06:00:40.679+00005683: debug : virEventPollDispatchHandles:469 : i=7 w=10 >2012-11-09 06:00:40.679+00005683: debug : virEventPollDispatchHandles:483 : EVENT_POLL_DISPATCH_HANDLE: watch=10 events=9 >2012-11-09 06:00:40.679+00005683: debug : virObjectRef:168 : OBJECT_REF: obj=0x7f3b08003230 >2012-11-09 06:00:40.679+00005683: error : qemuMonitorIO:613 : internal error End of file from monitor >2012-11-09 06:00:40.679+00005683: debug : qemuMonitorIO:646 : Error on monitor internal error End of file from monitor >2012-11-09 06:00:40.679+00005683: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=10 events=12 >2012-11-09 06:00:40.679+00005683: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 603646048 >2012-11-09 06:00:40.679+00005683: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7f3b08003230 >2012-11-09 06:00:40.679+00005683: debug : qemuMonitorIO:669 : Triggering EOF callback >2012-11-09 06:00:40.679+00005683: debug : qemuProcessHandleMonitorEOF:282 : Received EOF on 0x7f3b1000d360 'test' >2012-11-09 06:00:40.679+00005683: debug : qemuProcessHandleMonitorEOF:290 : Domain is being destroyed, EOF is expected >2012-11-09 06:00:40.679+00005683: debug : virEventPollDispatchHandles:469 : i=8 w=11 >2012-11-09 06:00:40.679+00005683: debug : virEventPollDispatchHandles:483 : EVENT_POLL_DISPATCH_HANDLE: watch=11 events=9 >2012-11-09 06:00:40.679+00005683: debug : virObjectRef:168 : OBJECT_REF: obj=0x7f3b080033b0 >2012-11-09 06:00:40.679+00005683: error : qemuAgentIO:642 : internal error End of file from monitor >2012-11-09 06:00:40.679+00005683: debug : qemuAgentIO:675 : Error on monitor internal error End of file from monitor >2012-11-09 06:00:40.679+00005683: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=11 events=12 >2012-11-09 06:00:40.679+00005683: debug : virEventPollInterruptLocked:697 : Skip interrupt, 1 603646048 >2012-11-09 06:00:40.679+00005683: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7f3b080033b0 >2012-11-09 06:00:40.679+00005683: debug : qemuAgentIO:698 : Triggering EOF callback >2012-11-09 06:00:40.679+00005683: debug : qemuProcessHandleAgentEOF:125 : Received EOF from agent on 0x7f3b1000d360 'test' >2012-11-09 06:00:40.679+00005683: debug : qemuAgentClose:814 : mon=0x7f3b080033b0 >2012-11-09 06:00:40.679+00005686: debug : qemuAgentSend:900 : Send command resulted in error internal error End of file from monitor >2012-11-09 06:00:40.679+00005686: debug : virEventPollUpdateHandle:146 : EVENT_POLL_UPDATE_HANDLE: watch=11 events=12 >2012-11-09 06:00:40.679+00005686: debug : virEventPollInterruptLocked:701 : Interrupting >2012-11-09 06:00:40.679+00005686: debug : qemuAgentCommand:1023 : Receive command reply ret=-1 rxObject=(nil) >2012-11-09 06:00:40.679+00005686: debug : qemuDomainObjEndJob:936 : Stopping job: modify (async=none) >2012-11-09 06:00:40.679+00005686: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7f3b1000d360 >2012-11-09 06:00:40.679+00005688: debug : qemuDomainObjBeginJobInternal:807 : Starting job: modify (async=none) >2012-11-09 06:00:40.679+00005686: debug : virDomainFree:2281 : dom=0x7f3af80008e0, (VM: name=test, uuid=aa5d3f4d-ac22-c76a-aa95-53bfb224f47a) >2012-11-09 06:00:40.679+00005686: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7f3af80008e0 >2012-11-09 06:00:40.679+00005686: debug : virObjectUnref:137 : OBJECT_DISPOSE: obj=0x7f3af80008e0 >2012-11-09 06:00:40.679+00005686: debug : virDomainDispose:225 : release domain 0x7f3af80008e0 test aa5d3f4d-ac22-c76a-aa95-53bfb224f47a >2012-11-09 06:00:40.679+00005686: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7f3af0000a90 > > > ====== end of log ===== >
You cannot view the attachment while viewing its details because your browser does not support IFRAMEs.
View the attachment on a separate page
.
View Attachment As Raw
Actions:
View
Attachments on
bug 872420
:
636969
|
636989
| 641268 |
649590