Attachment 924092 Details for Bug 1126685 – guest qemu log

guest qemu log

r6.5.log (text/plain), 16.46 KB, created by hongming on 2014-08-05 05:33:29 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: hongming

Created: 2014-08-05 05:33:29 UTC

Size: 16.46 KB

patch

obsolete

>qemu: terminating on signal 15 from pid 22094
>2014-08-05 02:57:04.547+0000: shutting down
>2014-08-05 02:57:08.536+0000: starting up
>LC_ALL=C PATH=/sbin:/usr/sbin:/bin:/usr/bin QEMU_AUDIO_DRV=none /usr/libexec/qemu-kvm -name r6.5 -S -M rhel6.4.0 -enable-kvm -m 9814 -realtime mlock=off -smp 4,sockets=4,cores=1,threads=1 -uuid dbe79b60-78e3-03d1-25c7-2c97bea10217 -nodefconfig -nodefaults -chardev socket,id=charmonitor,path=/var/lib/libvirt/qemu/r6.5.monitor,server,nowait -mon chardev=charmonitor,id=monitor,mode=control -rtc base=utc -no-shutdown -device piix3-usb-uhci,id=usb,bus=pci.0,addr=0x1.0x2 -device virtio-serial-pci,id=virtio-serial0,bus=pci.0,addr=0x6 -drive file=/var/lib/libvirt/images/rhel6.5-20140306.img,if=none,id=drive-ide0-0-0,format=raw,cache=none -device ide-drive,bus=ide.0,unit=0,drive=drive-ide0-0-0,id=ide0-0-0,bootindex=1 -netdev tap,fd=23,id=hostnet0 -device rtl8139,netdev=hostnet0,id=net0,mac=52:54:00:73:b1:91,bus=pci.0,addr=0x3 -chardev pty,id=charserial0 -device isa-serial,chardev=charserial0,id=serial0 -chardev socket,id=charchannel0,path=/var/lib/libvirt/qemu/rhel6.5.agent,server,nowait -device virtserialport,bus=virtio-serial0.0,nr=1,chardev=charchannel0,id=channel0,name=org.qemu.guest_agent.0 -vnc 127.0.0.1:0 -vga cirrus -device intel-hda,id=sound0,bus=pci.0,addr=0x4 -device hda-duplex,id=sound0-codec0,bus=sound0.0,cad=0 -msg timestamp=on
>2014-08-05 02:57:08.537+0000: 22293: debug : virFileClose:72 : Closed fd 22
>2014-08-05 02:57:08.537+0000: 22293: debug : virFileClose:72 : Closed fd 28
>2014-08-05 02:57:08.538+0000: 22293: debug : virFileClose:72 : Closed fd 3
>2014-08-05 02:57:08.538+0000: 22294: debug : virCommandHook:2087 : Run hook 0x49b760 0x7f0683c38370
>2014-08-05 02:57:08.538+0000: 22294: debug : qemuProcessHook:2841 : Obtaining domain lock
>2014-08-05 02:57:08.538+0000: 22294: debug : virSecuritySELinuxSetSecuritySocketLabel:1671 : Setting VM r6.5 socket context unconfined_u:system_r:svirt_t:s0:c413,c1012
>2014-08-05 02:57:08.539+0000: 22294: debug : virDomainLockProcessStart:170 : plugin=0x7f067400b830 dom=0x7f0674003b70 paused=1 fd=0x7f0683c3797c
>2014-08-05 02:57:08.548+0000: 22294: debug : virDomainLockManagerNew:128 : plugin=0x7f067400b830 dom=0x7f0674003b70 withResources=1
>2014-08-05 02:57:08.548+0000: 22294: debug : virLockManagerPluginGetDriver:283 : plugin=0x7f067400b830
>2014-08-05 02:57:08.548+0000: 22294: debug : virLockManagerNew:307 : driver=0x7f0689f291e0 type=0 nparams=5 params=0x7f0683c377f0 flags=0
>2014-08-05 02:57:08.548+0000: 22294: debug : virLockManagerLogParams:107 :   key=uuid type=uuid value=dbe79b60-78e3-03d1-25c7-2c97bea10217
>2014-08-05 02:57:08.548+0000: 22294: debug : virLockManagerLogParams:100 :   key=name type=string value=r6.5
>2014-08-05 02:57:08.548+0000: 22294: debug : virLockManagerLogParams:88 :   key=id type=uint value=21
>2014-08-05 02:57:08.548+0000: 22294: debug : virLockManagerLogParams:88 :   key=pid type=uint value=22294
>2014-08-05 02:57:08.548+0000: 22294: debug : virLockManagerLogParams:103 :   key=uri type=cstring value=qemu:///system
>2014-08-05 02:57:08.548+0000: 22294: debug : virDomainLockManagerNew:140 : Adding leases
>2014-08-05 02:57:08.548+0000: 22294: debug : virDomainLockManagerNew:145 : Adding disks
>2014-08-05 02:57:08.548+0000: 22294: debug : virDomainLockManagerAddDisk:86 : Add disk /var/lib/libvirt/images/rhel6.5-20140306.img
>2014-08-05 02:57:08.548+0000: 22294: debug : virLockManagerAddResource:336 : lock=0x7f06740be580 type=0 name=/var/lib/libvirt/images/rhel6.5-20140306.img nparams=0 params=(nil) flags=0
>2014-08-05 02:57:08.548+0000: 22294: debug : virLockManagerAcquire:354 : lock=0x7f06740be580 state='(null)' flags=3 action=0 fd=0x7f0683c3797c
>2014-08-05 02:57:08.548+0000: 22294: debug : virLockManagerFree:391 : lock=0x7f06740be580
>2014-08-05 02:57:08.548+0000: 22294: debug : qemuProcessHook:2867 : Moving process to cgroup
>2014-08-05 02:57:08.548+0000: 22294: debug : virCgroupNew:617 : New group /libvirt/qemu/r6.5
>2014-08-05 02:57:08.548+0000: 22294: debug : virCgroupDetect:273 : Detected mount/mapping 0:cpu at /cgroup/cpu in 
>2014-08-05 02:57:08.548+0000: 22294: debug : virCgroupDetect:273 : Detected mount/mapping 1:cpuacct at /cgroup/cpuacct in 
>2014-08-05 02:57:08.549+0000: 22294: debug : virCgroupDetect:273 : Detected mount/mapping 2:cpuset at /cgroup/cpuset in 
>2014-08-05 02:57:08.549+0000: 22294: debug : virCgroupDetect:273 : Detected mount/mapping 3:memory at /cgroup/memory in 
>2014-08-05 02:57:08.549+0000: 22294: debug : virCgroupDetect:273 : Detected mount/mapping 4:devices at /cgroup/devices in 
>2014-08-05 02:57:08.549+0000: 22294: debug : virCgroupDetect:273 : Detected mount/mapping 5:freezer at /cgroup/freezer in 
>2014-08-05 02:57:08.549+0000: 22294: debug : virCgroupDetect:273 : Detected mount/mapping 6:blkio at /cgroup/blkio in 
>2014-08-05 02:57:08.549+0000: 22294: debug : virCgroupMakeGroup:535 : Make group /libvirt/qemu/r6.5
>2014-08-05 02:57:08.549+0000: 22294: debug : virCgroupMakeGroup:560 : Make controller /cgroup/cpu/libvirt/qemu/r6.5/
>2014-08-05 02:57:08.549+0000: 22294: debug : virCgroupMakeGroup:560 : Make controller /cgroup/cpuacct/libvirt/qemu/r6.5/
>2014-08-05 02:57:08.549+0000: 22294: debug : virCgroupMakeGroup:560 : Make controller /cgroup/cpuset/libvirt/qemu/r6.5/
>2014-08-05 02:57:08.549+0000: 22294: debug : virCgroupMakeGroup:560 : Make controller /cgroup/memory/libvirt/qemu/r6.5/
>2014-08-05 02:57:08.549+0000: 22294: debug : virCgroupMakeGroup:560 : Make controller /cgroup/devices/libvirt/qemu/r6.5/
>2014-08-05 02:57:08.549+0000: 22294: debug : virCgroupMakeGroup:560 : Make controller /cgroup/freezer/libvirt/qemu/r6.5/
>2014-08-05 02:57:08.549+0000: 22294: debug : virCgroupMakeGroup:560 : Make controller /cgroup/blkio/libvirt/qemu/r6.5/
>2014-08-05 02:57:08.549+0000: 22294: debug : virCgroupSetValueStr:331 : Set value '/cgroup/cpu/libvirt/qemu/r6.5/tasks' to '22294'
>2014-08-05 02:57:08.552+0000: 22294: debug : virFileClose:72 : Closed fd 3
>2014-08-05 02:57:08.552+0000: 22294: debug : virCgroupSetValueStr:331 : Set value '/cgroup/cpuacct/libvirt/qemu/r6.5/tasks' to '22294'
>2014-08-05 02:57:08.555+0000: 22294: debug : virFileClose:72 : Closed fd 3
>2014-08-05 02:57:08.556+0000: 22294: debug : virCgroupSetValueStr:331 : Set value '/cgroup/cpuset/libvirt/qemu/r6.5/tasks' to '22294'
>2014-08-05 02:57:08.561+0000: 22294: debug : virFileClose:72 : Closed fd 3
>2014-08-05 02:57:08.561+0000: 22294: debug : virCgroupSetValueStr:331 : Set value '/cgroup/memory/libvirt/qemu/r6.5/tasks' to '22294'
>2014-08-05 02:57:08.564+0000: 22294: debug : virFileClose:72 : Closed fd 3
>2014-08-05 02:57:08.564+0000: 22294: debug : virCgroupSetValueStr:331 : Set value '/cgroup/devices/libvirt/qemu/r6.5/tasks' to '22294'
>2014-08-05 02:57:08.570+0000: 22294: debug : virFileClose:72 : Closed fd 3
>2014-08-05 02:57:08.570+0000: 22294: debug : virCgroupSetValueStr:331 : Set value '/cgroup/freezer/libvirt/qemu/r6.5/tasks' to '22294'
>2014-08-05 02:57:08.573+0000: 22294: debug : virFileClose:72 : Closed fd 3
>2014-08-05 02:57:08.573+0000: 22294: debug : virCgroupSetValueStr:331 : Set value '/cgroup/blkio/libvirt/qemu/r6.5/tasks' to '22294'
>2014-08-05 02:57:08.577+0000: 22294: debug : virFileClose:72 : Closed fd 3
>2014-08-05 02:57:08.578+0000: 22294: debug : qemuProcessInitCpuAffinity:2126 : Set CPU affinity with specified cpuset
>2014-08-05 02:57:08.578+0000: 22294: debug : qemuProcessHook:2880 : Setting up security labelling
>2014-08-05 02:57:08.578+0000: 22294: debug : virSecuritySELinuxSetSecurityProcessLabel:1578 : label=unconfined_u:system_r:svirt_t:s0:c413,c1012
>2014-08-05 02:57:08.578+0000: 22294: debug : virSecurityDACSetProcessLabel:841 : Dropping privileges of DEF to 107:107, 2 supplemental groups
>2014-08-05 02:57:08.578+0000: 22294: debug : qemuProcessHook:2887 : Hook complete ret=0
>2014-08-05 02:57:08.578+0000: 22294: debug : virCommandHook:2089 : Done hook 0
>2014-08-05 02:57:08.578+0000: 22294: debug : virCommandHook:2103 : Notifying parent for handshake start on 25
>2014-08-05 02:57:08.578+0000: 22294: debug : virCommandHook:2127 : Waiting on parent for handshake complete on 26
>2014-08-05 02:57:08.622+0000: 22294: debug : virFileClose:72 : Closed fd 25
>2014-08-05 02:57:08.623+0000: 22294: debug : virFileClose:72 : Closed fd 26
>2014-08-05 02:57:08.623+0000: 22294: debug : virCommandHook:2148 : Hook is done 0
>char device redirected to /dev/pts/1
>qemu: terminating on signal 15 from pid 22094
>2014-08-05 03:58:49.543+0000: shutting down
>2014-08-05 03:59:27.241+0000: starting up
>LC_ALL=C PATH=/sbin:/usr/sbin:/bin:/usr/bin QEMU_AUDIO_DRV=none /usr/libexec/qemu-kvm -name r6.5 -S -M rhel6.4.0 -enable-kvm -m 9814 -realtime mlock=off -smp 1,sockets=1,cores=1,threads=1 -uuid dbe79b60-78e3-03d1-25c7-2c97bea10217 -nodefconfig -nodefaults -chardev socket,id=charmonitor,path=/var/lib/libvirt/qemu/r6.5.monitor,server,nowait -mon chardev=charmonitor,id=monitor,mode=control -rtc base=utc -no-shutdown -device piix3-usb-uhci,id=usb,bus=pci.0,addr=0x1.0x2 -device virtio-serial-pci,id=virtio-serial0,bus=pci.0,addr=0x6 -drive file=/var/lib/libvirt/images/rhel6.5-20140306.img,if=none,id=drive-ide0-0-0,format=raw,cache=none -device ide-drive,bus=ide.0,unit=0,drive=drive-ide0-0-0,id=ide0-0-0,bootindex=1 -netdev tap,fd=23,id=hostnet0 -device rtl8139,netdev=hostnet0,id=net0,mac=52:54:00:73:b1:91,bus=pci.0,addr=0x3 -chardev pty,id=charserial0 -device isa-serial,chardev=charserial0,id=serial0 -chardev socket,id=charchannel0,path=/var/lib/libvirt/qemu/rhel6.5.agent,server,nowait -device virtserialport,bus=virtio-serial0.0,nr=1,chardev=charchannel0,id=channel0,name=org.qemu.guest_agent.0 -vnc 127.0.0.1:0 -vga cirrus -device intel-hda,id=sound0,bus=pci.0,addr=0x4 -device hda-duplex,id=sound0-codec0,bus=sound0.0,cad=0 -msg timestamp=on
>2014-08-05 03:59:27.242+0000: 23259: debug : virFileClose:72 : Closed fd 22
>2014-08-05 03:59:27.242+0000: 23259: debug : virFileClose:72 : Closed fd 28
>2014-08-05 03:59:27.243+0000: 23259: debug : virFileClose:72 : Closed fd 3
>2014-08-05 03:59:27.243+0000: 23260: debug : virCommandHook:2087 : Run hook 0x49b760 0x7f0682836370
>2014-08-05 03:59:27.243+0000: 23260: debug : qemuProcessHook:2841 : Obtaining domain lock
>2014-08-05 03:59:27.243+0000: 23260: debug : virSecuritySELinuxSetSecuritySocketLabel:1671 : Setting VM r6.5 socket context unconfined_u:system_r:svirt_t:s0:c242,c408
>2014-08-05 03:59:27.244+0000: 23260: debug : virDomainLockProcessStart:170 : plugin=0x7f067400b830 dom=0x7f0674003b70 paused=1 fd=0x7f068283597c
>2014-08-05 03:59:27.244+0000: 23260: debug : virDomainLockManagerNew:128 : plugin=0x7f067400b830 dom=0x7f0674003b70 withResources=1
>2014-08-05 03:59:27.244+0000: 23260: debug : virLockManagerPluginGetDriver:283 : plugin=0x7f067400b830
>2014-08-05 03:59:27.244+0000: 23260: debug : virLockManagerNew:307 : driver=0x7f0689f291e0 type=0 nparams=5 params=0x7f06828357f0 flags=0
>2014-08-05 03:59:27.244+0000: 23260: debug : virLockManagerLogParams:107 :   key=uuid type=uuid value=dbe79b60-78e3-03d1-25c7-2c97bea10217
>2014-08-05 03:59:27.244+0000: 23260: debug : virLockManagerLogParams:100 :   key=name type=string value=r6.5
>2014-08-05 03:59:27.244+0000: 23260: debug : virLockManagerLogParams:88 :   key=id type=uint value=22
>2014-08-05 03:59:27.244+0000: 23260: debug : virLockManagerLogParams:88 :   key=pid type=uint value=23260
>2014-08-05 03:59:27.244+0000: 23260: debug : virLockManagerLogParams:103 :   key=uri type=cstring value=qemu:///system
>2014-08-05 03:59:27.244+0000: 23260: debug : virDomainLockManagerNew:140 : Adding leases
>2014-08-05 03:59:27.244+0000: 23260: debug : virDomainLockManagerNew:145 : Adding disks
>2014-08-05 03:59:27.244+0000: 23260: debug : virDomainLockManagerAddDisk:86 : Add disk /var/lib/libvirt/images/rhel6.5-20140306.img
>2014-08-05 03:59:27.244+0000: 23260: debug : virLockManagerAddResource:336 : lock=0x7f06700042d0 type=0 name=/var/lib/libvirt/images/rhel6.5-20140306.img nparams=0 params=(nil) flags=0
>2014-08-05 03:59:27.244+0000: 23260: debug : virLockManagerAcquire:354 : lock=0x7f06700042d0 state='(null)' flags=3 action=0 fd=0x7f068283597c
>2014-08-05 03:59:27.244+0000: 23260: debug : virLockManagerFree:391 : lock=0x7f06700042d0
>2014-08-05 03:59:27.244+0000: 23260: debug : qemuProcessHook:2867 : Moving process to cgroup
>2014-08-05 03:59:27.244+0000: 23260: debug : virCgroupNew:617 : New group /libvirt/qemu/r6.5
>2014-08-05 03:59:27.244+0000: 23260: debug : virCgroupDetect:273 : Detected mount/mapping 0:cpu at /cgroup/cpu in 
>2014-08-05 03:59:27.244+0000: 23260: debug : virCgroupDetect:273 : Detected mount/mapping 1:cpuacct at /cgroup/cpuacct in 
>2014-08-05 03:59:27.244+0000: 23260: debug : virCgroupDetect:273 : Detected mount/mapping 2:cpuset at /cgroup/cpuset in 
>2014-08-05 03:59:27.244+0000: 23260: debug : virCgroupDetect:273 : Detected mount/mapping 3:memory at /cgroup/memory in 
>2014-08-05 03:59:27.244+0000: 23260: debug : virCgroupDetect:273 : Detected mount/mapping 4:devices at /cgroup/devices in 
>2014-08-05 03:59:27.244+0000: 23260: debug : virCgroupDetect:273 : Detected mount/mapping 5:freezer at /cgroup/freezer in 
>2014-08-05 03:59:27.244+0000: 23260: debug : virCgroupDetect:273 : Detected mount/mapping 6:blkio at /cgroup/blkio in 
>2014-08-05 03:59:27.244+0000: 23260: debug : virCgroupMakeGroup:535 : Make group /libvirt/qemu/r6.5
>2014-08-05 03:59:27.244+0000: 23260: debug : virCgroupMakeGroup:560 : Make controller /cgroup/cpu/libvirt/qemu/r6.5/
>2014-08-05 03:59:27.244+0000: 23260: debug : virCgroupMakeGroup:560 : Make controller /cgroup/cpuacct/libvirt/qemu/r6.5/
>2014-08-05 03:59:27.244+0000: 23260: debug : virCgroupMakeGroup:560 : Make controller /cgroup/cpuset/libvirt/qemu/r6.5/
>2014-08-05 03:59:27.244+0000: 23260: debug : virCgroupMakeGroup:560 : Make controller /cgroup/memory/libvirt/qemu/r6.5/
>2014-08-05 03:59:27.244+0000: 23260: debug : virCgroupMakeGroup:560 : Make controller /cgroup/devices/libvirt/qemu/r6.5/
>2014-08-05 03:59:27.244+0000: 23260: debug : virCgroupMakeGroup:560 : Make controller /cgroup/freezer/libvirt/qemu/r6.5/
>2014-08-05 03:59:27.244+0000: 23260: debug : virCgroupMakeGroup:560 : Make controller /cgroup/blkio/libvirt/qemu/r6.5/
>2014-08-05 03:59:27.244+0000: 23260: debug : virCgroupSetValueStr:331 : Set value '/cgroup/cpu/libvirt/qemu/r6.5/tasks' to '23260'
>2014-08-05 03:59:27.247+0000: 23260: debug : virFileClose:72 : Closed fd 3
>2014-08-05 03:59:27.248+0000: 23260: debug : virCgroupSetValueStr:331 : Set value '/cgroup/cpuacct/libvirt/qemu/r6.5/tasks' to '23260'
>2014-08-05 03:59:27.253+0000: 23260: debug : virFileClose:72 : Closed fd 3
>2014-08-05 03:59:27.254+0000: 23260: debug : virCgroupSetValueStr:331 : Set value '/cgroup/cpuset/libvirt/qemu/r6.5/tasks' to '23260'
>2014-08-05 03:59:27.262+0000: 23260: debug : virFileClose:72 : Closed fd 3
>2014-08-05 03:59:27.262+0000: 23260: debug : virCgroupSetValueStr:331 : Set value '/cgroup/memory/libvirt/qemu/r6.5/tasks' to '23260'
>2014-08-05 03:59:27.266+0000: 23260: debug : virFileClose:72 : Closed fd 3
>2014-08-05 03:59:27.266+0000: 23260: debug : virCgroupSetValueStr:331 : Set value '/cgroup/devices/libvirt/qemu/r6.5/tasks' to '23260'
>2014-08-05 03:59:27.270+0000: 23260: debug : virFileClose:72 : Closed fd 3
>2014-08-05 03:59:27.270+0000: 23260: debug : virCgroupSetValueStr:331 : Set value '/cgroup/freezer/libvirt/qemu/r6.5/tasks' to '23260'
>2014-08-05 03:59:27.275+0000: 23260: debug : virFileClose:72 : Closed fd 3
>2014-08-05 03:59:27.275+0000: 23260: debug : virCgroupSetValueStr:331 : Set value '/cgroup/blkio/libvirt/qemu/r6.5/tasks' to '23260'
>2014-08-05 03:59:27.281+0000: 23260: debug : virFileClose:72 : Closed fd 3
>2014-08-05 03:59:27.282+0000: 23260: debug : qemuProcessInitCpuAffinity:2126 : Set CPU affinity with specified cpuset
>2014-08-05 03:59:27.282+0000: 23260: debug : qemuProcessHook:2880 : Setting up security labelling
>2014-08-05 03:59:27.282+0000: 23260: debug : virSecuritySELinuxSetSecurityProcessLabel:1578 : label=unconfined_u:system_r:svirt_t:s0:c242,c408
>2014-08-05 03:59:27.282+0000: 23260: debug : virSecurityDACSetProcessLabel:841 : Dropping privileges of DEF to 107:107, 2 supplemental groups
>2014-08-05 03:59:27.282+0000: 23260: debug : qemuProcessHook:2887 : Hook complete ret=0
>2014-08-05 03:59:27.282+0000: 23260: debug : virCommandHook:2089 : Done hook 0
>2014-08-05 03:59:27.282+0000: 23260: debug : virCommandHook:2103 : Notifying parent for handshake start on 25
>2014-08-05 03:59:27.282+0000: 23260: debug : virCommandHook:2127 : Waiting on parent for handshake complete on 26
>2014-08-05 03:59:27.335+0000: 23260: debug : virFileClose:72 : Closed fd 25
>2014-08-05 03:59:27.336+0000: 23260: debug : virFileClose:72 : Closed fd 26
>2014-08-05 03:59:27.336+0000: 23260: debug : virCommandHook:2148 : Hook is done 0
>char device redirected to /dev/pts/1
>2014-08-05 03:59:27.633+0000: shutting down
>qemu: terminating on signal 15 from pid 22094

Actions: View

Attachments on bug 1126685: 924091 | 924092