Attachment 598078 Details for Bug 840038 – File: var_log_messages

File: var_log_messages

var_log_messages (text/plain), 14.27 KB, created by Cristian Ciupitu on 2012-07-13 14:00:29 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Cristian Ciupitu

Created: 2012-07-13 14:00:29 UTC

Size: 14.27 KB

patch

obsolete

>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.985+00004176: debug : virEventPollDispatchTimeouts:415 : Dispatch 0
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.985+00004176: debug : virEventPollDispatchHandles:460 : Dispatch 7
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.985+00004176: debug : virEventPollDispatchHandles:474 : i=0 w=1
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.985+00004176: debug : virEventPollDispatchHandles:488 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.985+00004176: debug : virEventPollDispatchHandles:474 : i=1 w=2
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.985+00004176: debug : virEventPollDispatchHandles:474 : i=2 w=3
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.985+00004176: debug : virEventPollDispatchHandles:488 : EVENT_POLL_DISPATCH_HANDLE: watch=3 events=1
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virNetSocketNew:119 : localAddr=0x7fff0517abb0 remoteAddr=0x7fff0517ac40 fd=16 errfd=-1 pid=0
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virNetSocketNew:179 : RPC_SOCKET_NEW: sock=0x1030170 refs=1 fd=16 errfd=-1 pid=0 localAddr=127.0.0.1;0, remoteAddr=127.0.0.1;0
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virNetServerClientNew:346 : sock=0x1030170 auth=2 tls=(nil)
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollAddTimeout:225 : Used 0 timeout slots, adding at least 10 more
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollInterruptLocked:702 : Skip interrupt, 1 416516224
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollAddTimeout:248 : EVENT_POLL_ADD_TIMEOUT: timer=1 frequency=-1 cb=0x7f3b190a0250 opaque=0x1030330 ff=(nil)
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virNetMessageNew:48 : msg=0x7f3b0b17b010 tracked=1
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virNetServerClientNew:380 : RPC_SERVER_CLIENT_NEW: client=0x1030330 refs=1 sock=0x1030170
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virNetServerClientCalculateHandleMode:137 : tls=(nil) hs=-1, rx=0x7f3b0b17b010 tx=(nil)
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virNetServerClientCalculateHandleMode:167 : mode=1
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virNetServerClientRegisterEvent:187 : Registering client event callback 1
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virNetSocketRef:713 : RPC_SOCKET_REF: sock=0x1030170 refs=2
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollInterruptLocked:702 : Skip interrupt, 1 416516224
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollAddHandle:141 : EVENT_POLL_ADD_HANDLE: watch=8 fd=16 events=1 cb=0x7f3b190a72a0 opaque=0x1030170 ff=0x7f3b190a78f0
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virNetServerClientRef:397 : RPC_SERVER_CLIENT_REF: client=0x1030330 refs=3
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virKeepAliveNew:244 : client=0x1030330, interval=5, count=5
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollInterruptLocked:702 : Skip interrupt, 1 416516224
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollAddTimeout:248 : EVENT_POLL_ADD_TIMEOUT: timer=2 frequency=-1 cb=0x7f3b190a3c60 opaque=0x1030850 ff=0x7f3b190a3e20
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virKeepAliveNew:277 : RPC_KEEPALIVE_NEW: ka=0x1030850 client=0x1030330 refs=2
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virNetServerClientFree:591 : RPC_SERVER_CLIENT_FREE: client=0x1030330 refs=4
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollDispatchHandles:474 : i=3 w=4
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollDispatchHandles:474 : i=4 w=5
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollDispatchHandles:474 : i=5 w=6
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollDispatchHandles:474 : i=6 w=7
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollCleanupTimeouts:506 : Cleanup 2
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollCleanupHandles:554 : Cleanup 8
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventRunDefaultImpl:244 : running default event implementation
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollCleanupTimeouts:506 : Cleanup 2
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollCleanupHandles:554 : Cleanup 8
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollMakePollFDs:383 : Prepare n=0 w=1, f=5 e=1 d=0
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollMakePollFDs:383 : Prepare n=1 w=2, f=7 e=1 d=0
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollMakePollFDs:383 : Prepare n=2 w=3, f=10 e=1 d=0
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollMakePollFDs:383 : Prepare n=3 w=4, f=11 e=1 d=0
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollMakePollFDs:383 : Prepare n=4 w=5, f=13 e=1 d=0
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollMakePollFDs:383 : Prepare n=5 w=6, f=14 e=1 d=0
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollMakePollFDs:383 : Prepare n=6 w=7, f=15 e=1 d=0
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollMakePollFDs:383 : Prepare n=7 w=8, f=16 e=1 d=0
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollCalculateTimeout:325 : Calculate expiry of 2 timers
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollCalculateTimeout:351 : Timeout at 0 due in -1 ms
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollRunOnce:619 : EVENT_POLL_RUN: nhandles=8 timeout=-1
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollRunOnce:630 : Poll got 2 event(s)
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollDispatchTimeouts:415 : Dispatch 2
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollDispatchHandles:460 : Dispatch 8
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollDispatchHandles:474 : i=0 w=1
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollDispatchHandles:474 : i=1 w=2
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollDispatchHandles:474 : i=2 w=3
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollDispatchHandles:488 : EVENT_POLL_DISPATCH_HANDLE: watch=3 events=1
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virNetSocketNew:119 : localAddr=0x7fff0517abb0 remoteAddr=0x7fff0517ac40 fd=17 errfd=-1 pid=0
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virNetSocketNew:179 : RPC_SOCKET_NEW: sock=0x102b9a0 refs=1 fd=17 errfd=-1 pid=0 localAddr=127.0.0.1;0, remoteAddr=127.0.0.1;0
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virNetServerClientNew:346 : sock=0x102b9a0 auth=2 tls=(nil)
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollInterruptLocked:702 : Skip interrupt, 1 416516224
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollAddTimeout:248 : EVENT_POLL_ADD_TIMEOUT: timer=3 frequency=-1 cb=0x7f3b190a0250 opaque=0x102bb60 ff=(nil)
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virNetMessageNew:48 : msg=0x7f3b0b13a010 tracked=1
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virNetServerClientNew:380 : RPC_SERVER_CLIENT_NEW: client=0x102bb60 refs=1 sock=0x102b9a0
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virNetServerClientCalculateHandleMode:137 : tls=(nil) hs=-1, rx=0x7f3b0b13a010 tx=(nil)
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virNetServerClientCalculateHandleMode:167 : mode=1
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virNetServerClientRegisterEvent:187 : Registering client event callback 1
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virNetSocketRef:713 : RPC_SOCKET_REF: sock=0x102b9a0 refs=2
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollInterruptLocked:702 : Skip interrupt, 1 416516224
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollAddHandle:141 : EVENT_POLL_ADD_HANDLE: watch=9 fd=17 events=1 cb=0x7f3b190a72a0 opaque=0x102b9a0 ff=0x7f3b190a78f0
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virNetServerClientRef:397 : RPC_SERVER_CLIENT_REF: client=0x102bb60 refs=3
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virKeepAliveNew:244 : client=0x102bb60, interval=5, count=5
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollInterruptLocked:702 : Skip interrupt, 1 416516224
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollAddTimeout:248 : EVENT_POLL_ADD_TIMEOUT: timer=4 frequency=-1 cb=0x7f3b190a3c60 opaque=0x1030970 ff=0x7f3b190a3e20
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virKeepAliveNew:277 : RPC_KEEPALIVE_NEW: ka=0x1030970 client=0x102bb60 refs=2
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virNetServerClientFree:591 : RPC_SERVER_CLIENT_FREE: client=0x102bb60 refs=4
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollDispatchHandles:474 : i=3 w=4
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollDispatchHandles:474 : i=4 w=5
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollDispatchHandles:474 : i=5 w=6
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollDispatchHandles:474 : i=6 w=7
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollDispatchHandles:474 : i=7 w=8
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollDispatchHandles:488 : EVENT_POLL_DISPATCH_HANDLE: watch=8 events=1
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virNetMessageDecodeLength:149 : Got length, now need 28 total (24 more)
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virNetServerClientCalculateHandleMode:137 : tls=(nil) hs=-1, rx=0x7f3b0b17b010 tx=(nil)
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virNetServerClientCalculateHandleMode:167 : mode=1
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.986+00004176: debug : virEventPollUpdateHandle:151 : EVENT_POLL_UPDATE_HANDLE: watch=8 events=1
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.987+00004176: debug : virEventPollInterruptLocked:702 : Skip interrupt, 1 416516224
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.987+00004176: debug : virNetServerClientDispatchRead:886 : RPC_SERVER_CLIENT_MSG_RX: client=0x1030330 len=28 prog=536903814 vers=1 proc=66 type=0 status=0 serial=0
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.987+00004176: debug : virKeepAliveCheckMessage:408 : ka=0x1030850, client=0x1030330, msg=0x7f3b0b17b010
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.987+00004176: debug : virNetServerDispatchNewMessage:203 : server=0x10268a0 client=0x1030330 message=0x7f3b0b17b010
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.987+00004176: debug : virNetServerProgramRef:87 : prog=0x10315b0 refs=3
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.987+00004176: debug : virNetMessageNew:48 : msg=0x7f3b0b0f9010 tracked=1
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.987+00004176: debug : virNetServerClientCalculateHandleMode:137 : tls=(nil) hs=-1, rx=0x7f3b0b0f9010 tx=(nil)
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.987+00004182: debug : virNetServerHandleJob:142 : server=0x10268a0 client=0x1030330 message=0x7f3b0b17b010 prog=0x10315b0
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.987+00004176: debug : virNetServerClientCalculateHandleMode:167 : mode=1
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.987+00004182: debug : virNetServerProgramDispatch:269 : prog=536903814 ver=1 type=0 status=0 serial=0 proc=66
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.987+00004176: debug : virEventPollUpdateHandle:151 : EVENT_POLL_UPDATE_HANDLE: watch=8 events=1
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.987+00004176: debug : virEventPollInterruptLocked:702 : Skip interrupt, 1 416516224
>Jul 13 14:07:38 hermes libvirtd[4176]: 2012-07-13 11:07:37.987+00004176: debug : virEventPollCleanupTimeouts:506 : Cleanup 4
>Jul 13 14:07:38 hermes abrt[4368]: Saved core dump of pid 4176 (/usr/sbin/libvirtd) to /var/spool/abrt/ccpp-2012-07-13-14:07:38-4176 (99684352 bytes)
>Jul 13 14:07:39 hermes systemd[1]: libvirtd.service: main process exited, code=dumped, status=11
>Jul 13 14:07:39 hermes systemd[1]: Unit libvirtd.service entered failed state.

Actions: View

Attachments on bug 840038: 598077 | 598078 | 598079 | 598080