1243313 – starting a qemu results spice core dump

RHEL Engineering is moving the tracking of its product development work on RHEL 6 through RHEL 9 to Red Hat Jira (issues.redhat.com). If you're a Red Hat customer, please continue to file support cases via the Red Hat customer portal. If you're not, please head to the "RHEL project" in Red Hat Jira and file new tickets here. Individual Bugzilla bugs in the statuses "NEW", "ASSIGNED", and "POST" are being migrated throughout September 2023. Bugs of Red Hat partners with an assigned Engineering Partner Manager (EPM) are migrated in late September as per pre-agreed dates. Bugs against components "kernel", "kernel-rt", and "kpatch" are only migrated if still in "NEW" or "ASSIGNED". If you cannot log in to RH Jira, please consult article #7032570. That failing, please send an e-mail to the RH Jira admins at rh-issues@redhat.com to troubleshoot your issue as a user management inquiry. The email creates a ServiceNow ticket with Red Hat. Individual Bugzilla bugs that are migrated will be moved to status "CLOSED", resolution "MIGRATED", and set with "MigratedToJIRA" in "Keywords". The link to the successor Jira issue will be found under "Links", have a little "two-footprint" icon next to it, and direct you to the "RHEL project" in Red Hat Jira (issue links are of type "https://issues.redhat.com/browse/RHEL-XXXX", where "X" is a digit). This same link will be available in a blue banner at the top of the page informing you that that bug has been migrated.

Bug 1243313 - starting a qemu results spice core dump

Summary: starting a qemu results spice core dump

Keywords:
Status:	CLOSED DUPLICATE of bug 1177326
Alias:	None
Product:	Red Hat Enterprise Linux 7
Classification:	Red Hat
Component:	spice
Sub Component:
Version:	7.2
Hardware:	x86_64
OS:	All
Priority:	high
Severity:	high
Target Milestone:	rc
Target Release:	---
Assignee:	Default Assignee for SPICE Bugs
QA Contact:	SPICE QE bug list
Docs Contact:
URL:
Whiteboard:
Depends On:
Blocks:
TreeView+	depends on / blocked

Reported:	2015-07-15 07:55 UTC by Xiaoqing Wei
Modified:	2015-07-16 15:39 UTC (History)
CC List:	7 users (show)
Fixed In Version:
Doc Type:	Bug Fix
Doc Text:
Clone Of:
Environment:
Last Closed:	2015-07-16 15:39:55 UTC
Target Upstream Version:
Embargoed:

Attachments	(Terms of Use)

Description Xiaoqing Wei 2015-07-15 07:55:10 UTC

Description of problem:
starting a qemu results spice core dump

Version-Release number of selected component (if applicable):

qemu-kvm-rhev-2.3.0-10.el7.x86_64
spice-server-0.12.4-12.el7.x86_64

How reproducible:
100%

Steps to Reproduce:
1. start a pre-defined vm, xml would be pasted in a separated comment later

2015-07-15 07:31:33.816+0000: starting up libvirt version: 1.2.17, package: 2.el7 (Red Hat, Inc. <http://bugzilla.redhat.com/bugzilla>, 2015-07-10-07:33:51, x86-035.build.eng.bos.redhat.com), qemu version: 2.3.0 (qemu-kvm-rhev-2.3.0-10.el7)
LC_ALL=C PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin QEMU_AUDIO_DRV=none /usr/libexec/qemu-kvm -name win2k12 -S -machine pc-i440fx-rhel7.2.0,accel=kvm,usb=off,vmport=off -cpu Opteron_G5,hv_time,hv_relaxed,hv_vapic,hv_spinlocks=0x1fff -m 2048 -realtime mlock=off -smp 2,sockets=2,cores=1,threads=1 -uuid 5ace6117-a351-41ba-a91f-a5ba657a59cf -no-user-config -nodefaults -chardev socket,id=charmonitor,path=/var/lib/libvirt/qemu/win2k12.monitor,server,nowait -mon chardev=charmonitor,id=monitor,mode=control -rtc base=localtime,driftfix=slew -global kvm-pit.lost_tick_policy=discard -no-hpet -no-shutdown -global PIIX4_PM.disable_s3=1 -global PIIX4_PM.disable_s4=1 -boot menu=on,strict=on -device ich9-usb-ehci1,id=usb,bus=pci.0,addr=0x6.0x7 -device ich9-usb-uhci1,masterbus=usb.0,firstport=0,bus=pci.0,multifunction=on,addr=0x6 -device ich9-usb-uhci2,masterbus=usb.0,firstport=2,bus=pci.0,addr=0x6.0x1 -device ich9-usb-uhci3,masterbus=usb.0,firstport=4,bus=pci.0,addr=0x6.0x2 -device virtio-scsi-pci,id=scsi0,bus=pci.0,addr=0x5 -device ahci,id=sata0,bus=pci.0,addr=0x7 -device virtio-serial-pci,id=virtio-serial0,bus=pci.0,addr=0x8 -drive file=/home/staf-kvm-devel/autotest-devel/client/tests/virt/shared/data/images/win2012-64-virtio.qcow2,if=none,id=drive-virtio-disk0,format=qcow2 -device virtio-blk-pci,scsi=off,bus=pci.0,addr=0x9,drive=drive-virtio-disk0,id=virtio-disk0,bootindex=2 -drive file=/home/staf-kvm-devel/autotest-devel/client/tests/virt/shared/data/images/win2012-64/autounattend.iso,if=none,media=cdrom,id=drive-sata0-0-1,readonly=on,format=raw -device ide-cd,bus=sata0.1,drive=drive-sata0-0-1,id=sata0-0-1 -drive file=/home/staf-kvm-devel/autotest-devel/client/tests/virt/shared/data/isos/ISO/Win2012/en_windows_server_2012_x64_dvd_915478.iso,if=none,id=drive-scsi0-0-0-0,readonly=on,format=raw,cache=none -device scsi-cd,bus=scsi0.0,channel=0,scsi-id=0,lun=0,drive=drive-scsi0-0-0-0,id=scsi0-0-0-0,bootindex=1 -netdev tap,fd=23,id=hostnet0 -device rtl8139,netdev=hostnet0,id=net0,mac=52:54:00:6e:24:0d,bus=pci.0,addr=0x3 -chardev pty,id=charserial0 -device isa-serial,chardev=charserial0,id=serial0 -chardev spicevmc,id=charchannel0,name=vdagent -device virtserialport,bus=virtio-serial0.0,nr=1,chardev=charchannel0,id=channel0,name=com.redhat.spice.0 -device usb-tablet,id=input0 -vnc 0.0.0.0:0 -device VGA,id=video0,vgamem_mb=16,bus=pci.0,addr=0x2 -device intel-hda,id=sound0,bus=pci.0,addr=0x4 -device hda-duplex,id=sound0-codec0,bus=sound0.0,cad=0 -chardev spicevmc,id=charredir0,name=usbredir -device usb-redir,chardev=charredir0,id=redir0 -chardev spicevmc,id=charredir1,name=usbredir -device usb-redir,chardev=charredir1,id=redir1 -device virtio-balloon-pci,id=balloon0,bus=pci.0,addr=0xa -msg timestamp=on
char device redirected to /dev/pts/2 (label charserial0)



2.
3.

Actual results:
((null):21283): Spice-ERROR **: reds.c:4015:do_spice_init: statistics shm_open failed, Permission denied


Expected results:

vm started and work well

Additional info:

this happens whatever VM xml has spice or not
eg:
spice + qxl
vnc + VGA

Comment 1 Xiaoqing Wei 2015-07-15 07:56:29 UTC

log for this qemu instance, from libvirt

char device redirected to /dev/pts/2 (label charserial0)
((null):21283): Spice-ERROR **: reds.c:4015:do_spice_init: statistics shm_open failed, Permission denied
Thread 5 (Thread 0x7efe312cf700 (LWP 21284)):
#0  __lll_lock_wait () at ../nptl/sysdeps/unix/sysv/linux/x86_64/lowlevellock.S:135
#1  0x00007efe3fc41d02 in _L_lock_791 () from /lib64/libpthread.so.0
#2  0x00007efe3fc41c08 in __GI___pthread_mutex_lock (mutex=mutex@entry=0x7efe4183f180 <qemu_global_mutex>) at pthread_mutex_lock.c:64
#3  0x00007efe41394439 in qemu_mutex_lock (mutex=mutex@entry=0x7efe4183f180 <qemu_global_mutex>) at util/qemu-thread-posix.c:73
#4  0x00007efe41150b9c in qemu_mutex_lock_iothread () at /usr/src/debug/qemu-2.3.0/cpus.c:1123
#5  0x00007efe413a2abe in call_rcu_thread (opaque=<optimized out>) at util/rcu.c:241
#6  0x00007efe3fc3fdc5 in start_thread (arg=0x7efe312cf700) at pthread_create.c:308
#7  0x00007efe397ce1bd in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:113
Thread 4 (Thread 0x7efe308b7700 (LWP 21286)):
#0  sem_timedwait () at ../nptl/sysdeps/unix/sysv/linux/x86_64/sem_timedwait.S:101
#1  0x00007efe41394667 in qemu_sem_timedwait (sem=sem@entry=0x7efe433806e8, ms=ms@entry=10000) at util/qemu-thread-posix.c:254
#2  0x00007efe4131879c in worker_thread (opaque=0x7efe43380680) at thread-pool.c:92
#3  0x00007efe3fc3fdc5 in start_thread (arg=0x7efe308b7700) at pthread_create.c:308
#4  0x00007efe397ce1bd in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:113
Thread 3 (Thread 0x7efe300b6700 (LWP 21287)):
#0  pthread_cond_wait@@GLIBC_2.3.2 () at ../nptl/sysdeps/unix/sysv/linux/x86_64/pthread_cond_wait.S:185
#1  0x00007efe41394519 in qemu_cond_wait (cond=<optimized out>, mutex=mutex@entry=0x7efe4183f180 <qemu_global_mutex>) at util/qemu-thread-posix.c:132
#2  0x00007efe4114f7ab in qemu_kvm_wait_io_event (cpu=<optimized out>) at /usr/src/debug/qemu-2.3.0/cpus.c:915
#3  qemu_kvm_cpu_thread_fn (arg=0x7efe43b4e000) at /usr/src/debug/qemu-2.3.0/cpus.c:952
#4  0x00007efe3fc3fdc5 in start_thread (arg=0x7efe300b6700) at pthread_create.c:308
#5  0x00007efe397ce1bd in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:113
Thread 2 (Thread 0x7efe2f8b5700 (LWP 21288)):
#0  pthread_cond_wait@@GLIBC_2.3.2 () at ../nptl/sysdeps/unix/sysv/linux/x86_64/pthread_cond_wait.S:185
#1  0x00007efe41394519 in qemu_cond_wait (cond=<optimized out>, mutex=mutex@entry=0x7efe4183f180 <qemu_global_mutex>) at util/qemu-thread-posix.c:132
#2  0x00007efe4114f7ab in qemu_kvm_wait_io_event (cpu=<optimized out>) at /usr/src/debug/qemu-2.3.0/cpus.c:915
#3  qemu_kvm_cpu_thread_fn (arg=0x7efe43bba000) at /usr/src/debug/qemu-2.3.0/cpus.c:952
#4  0x00007efe3fc3fdc5 in start_thread (arg=0x7efe2f8b5700) at pthread_create.c:308
#5  0x00007efe397ce1bd in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:113
Thread 1 (Thread 0x7efe41027c40 (LWP 21283)):
#0  0x00007efe3fc4622d in read () at ../sysdeps/unix/syscall-template.S:81
#1  0x00007efe3a747911 in read (__nbytes=255, __buf=0x7ffe7df580f0, __fd=<optimized out>) at /usr/include/bits/unistd.h:44
#2  spice_backtrace_gstack () at backtrace.c:100
#3  0x00007efe3a747a59 in spice_backtrace () at backtrace.c:131
#4  0x00007efe3a74f207 in spice_logv (log_domain=0x7efe3a7c57c6 "Spice", log_level=SPICE_LOG_LEVEL_ERROR, strloc=0x7efe3a7d0cf6 "reds.c:4015", function=0x7efe3a7d2eb0 <__FUNCTION__.31803> "do_spice_init", format=0x7efe3a7d2018 "statistics shm_open failed, %s", args=args@entry=0x7ffe7df58280) at log.c:108
#5  0x00007efe3a74f365 in spice_log (log_domain=log_domain@entry=0x7efe3a7c57c6 "Spice", log_level=log_level@entry=SPICE_LOG_LEVEL_ERROR, strloc=strloc@entry=0x7efe3a7d0cf6 "reds.c:4015", function=function@entry=0x7efe3a7d2eb0 <__FUNCTION__.31803> "do_spice_init", format=format@entry=0x7efe3a7d2018 "statistics shm_open failed, %s") at log.c:123
#6  0x00007efe3a734d84 in do_spice_init (core_interface=0x7efe417d03a0 <core_interface>) at reds.c:4015
#7  spice_server_init (s=<optimized out>, core=core@entry=0x7efe417d03a0 <core_interface>) at reds.c:4089
#8  0x00007efe412febf8 in qemu_spice_add_interface (sin=sin@entry=0x7efe43306218) at ui/spice-core.c:849
#9  0x00007efe41212c87 in vmc_register_interface (scd=0x7efe43306210) at spice-qemu-char.c:122
#10 0x00007efe4120ff87 in qemu_chr_fe_set_open (fe_open=1, chr=0x7efe43372880) at qemu-char.c:3784
#11 qemu_chr_add_handlers (s=0x7efe43372880, fd_can_read=fd_can_read@entry=0x7efe412cc240 <usbredir_chardev_can_read>, fd_read=fd_read@entry=0x7efe412cd380 <usbredir_chardev_read>, fd_event=fd_event@entry=0x7efe412cd300 <usbredir_chardev_event>, opaque=opaque@entry=0x7efe45b36000) at qemu-char.c:371
#12 0x00007efe412cae52 in usbredir_realize (udev=0x7efe45b36000, errp=<optimized out>) at hw/usb/redirect.c:1399
#13 0x00007efe412b57c6 in usb_device_realize (errp=0x7ffe7df583f0, dev=0x7efe45b36000) at hw/usb/bus.c:121
#14 usb_qdev_realize (qdev=0x7efe45b36000, errp=0x7ffe7df58430) at hw/usb/bus.c:258
#15 0x00007efe4125cb5d in device_set_realized (obj=0x7efe45b36000, value=<optimized out>, errp=0x7ffe7df58568) at hw/core/qdev.c:1058
#16 0x00007efe412ea29e in property_set_bool (obj=0x7efe45b36000, v=<optimized out>, opaque=0x7efe454fe680, name=<optimized out>, errp=0x7ffe7df58568) at qom/object.c:1514
#17 0x00007efe412ece27 in object_property_set_qobject (obj=obj@entry=0x7efe45b36000, value=value@entry=0x7efe44faf880, name=name@entry=0x7efe413d40dd "realized", errp=errp@entry=0x7ffe7df58568) at qom/qom-qobject.c:24
#18 0x00007efe412eb8b0 in object_property_set_bool (obj=obj@entry=0x7efe45b36000, value=value@entry=true, name=name@entry=0x7efe413d40dd "realized", errp=errp@entry=0x7ffe7df58568) at qom/object.c:905
#19 0x00007efe4120aac4 in qdev_device_add (opts=0x7efe43304b90) at qdev-monitor.c:574
#20 0x00007efe41213fc9 in device_init_func (opts=<optimized out>, opaque=<optimized out>) at vl.c:2139
#21 0x00007efe413a0deb in qemu_opts_foreach (list=<optimized out>, func=func@entry=0x7efe41213fc0 <device_init_func>, opaque=opaque@entry=0x0, abort_on_failure=abort_on_failure@entry=1) at util/qemu-option.c:1059
#22 0x00007efe411250b0 in main (argc=<optimized out>, argv=<optimized out>, envp=<optimized out>) at vl.c:4254
2015-07-15 07:31:35.824+0000: shutting down

Comment 2 Xiaoqing Wei 2015-07-15 07:58:01 UTC

this is the VM xml with vnc + VGA (uses spicevmc, though)

# virsh dumpxml win2k12 
<domain type='kvm'>
  <name>win2k12</name>
  <uuid>5ace6117-a351-41ba-a91f-a5ba657a59cf</uuid>
  <memory unit='KiB'>2097152</memory>
  <currentMemory unit='KiB'>2097152</currentMemory>
  <vcpu placement='static'>2</vcpu>
  <os>
    <type arch='x86_64' machine='pc-i440fx-rhel7.2.0'>hvm</type>
    <bootmenu enable='yes'/>
  </os>
  <features>
    <acpi/>
    <apic/>
    <pae/>
    <hyperv>
      <relaxed state='on'/>
      <vapic state='on'/>
      <spinlocks state='on' retries='8191'/>
    </hyperv>
    <vmport state='off'/>
  </features>
  <cpu mode='custom' match='exact'>
    <model fallback='allow'>Opteron_G5</model>
  </cpu>
  <clock offset='localtime'>
    <timer name='rtc' tickpolicy='catchup'/>
    <timer name='pit' tickpolicy='delay'/>
    <timer name='hpet' present='no'/>
    <timer name='hypervclock' present='yes'/>
  </clock>
  <on_poweroff>destroy</on_poweroff>
  <on_reboot>restart</on_reboot>
  <on_crash>restart</on_crash>
  <pm>
    <suspend-to-mem enabled='no'/>
    <suspend-to-disk enabled='no'/>
  </pm>
  <devices>
    <emulator>/usr/libexec/qemu-kvm</emulator>
    <disk type='file' device='disk'>
      <driver name='qemu' type='qcow2'/>
      <source file='/home/staf-kvm-devel/autotest-devel/client/tests/virt/shared/data/images/win2012-64-virtio.qcow2'/>
      <target dev='vda' bus='virtio'/>
      <boot order='2'/>
      <address type='pci' domain='0x0000' bus='0x00' slot='0x09' function='0x0'/>
    </disk>
    <disk type='file' device='cdrom'>
      <driver name='qemu' type='raw'/>
      <source file='/home/staf-kvm-devel/autotest-devel/client/tests/virt/shared/data/images/win2012-64/autounattend.iso'/>
      <target dev='sdb' bus='sata'/>
      <readonly/>
      <address type='drive' controller='0' bus='0' target='0' unit='1'/>
    </disk>
    <disk type='file' device='cdrom'>
      <driver name='qemu' type='raw' cache='none'/>
      <source file='/home/staf-kvm-devel/autotest-devel/client/tests/virt/shared/data/isos/ISO/Win2012/en_windows_server_2012_x64_dvd_915478.iso'/>
      <target dev='sda' bus='scsi'/>
      <readonly/>
      <boot order='1'/>
      <address type='drive' controller='0' bus='0' target='0' unit='0'/>
    </disk>
    <controller type='usb' index='0' model='ich9-ehci1'>
      <address type='pci' domain='0x0000' bus='0x00' slot='0x06' function='0x7'/>
    </controller>
    <controller type='usb' index='0' model='ich9-uhci1'>
      <master startport='0'/>
      <address type='pci' domain='0x0000' bus='0x00' slot='0x06' function='0x0' multifunction='on'/>
    </controller>
    <controller type='usb' index='0' model='ich9-uhci2'>
      <master startport='2'/>
      <address type='pci' domain='0x0000' bus='0x00' slot='0x06' function='0x1'/>
    </controller>
    <controller type='usb' index='0' model='ich9-uhci3'>
      <master startport='4'/>
      <address type='pci' domain='0x0000' bus='0x00' slot='0x06' function='0x2'/>
    </controller>
    <controller type='scsi' index='0' model='virtio-scsi'>
      <address type='pci' domain='0x0000' bus='0x00' slot='0x05' function='0x0'/>
    </controller>
    <controller type='pci' index='0' model='pci-root'/>
    <controller type='sata' index='0'>
      <address type='pci' domain='0x0000' bus='0x00' slot='0x07' function='0x0'/>
    </controller>
    <controller type='virtio-serial' index='0'>
      <address type='pci' domain='0x0000' bus='0x00' slot='0x08' function='0x0'/>
    </controller>
    <controller type='ide' index='0'>
      <address type='pci' domain='0x0000' bus='0x00' slot='0x01' function='0x1'/>
    </controller>
    <interface type='bridge'>
      <mac address='52:54:00:6e:24:0d'/>
      <source bridge='switch'/>
      <model type='rtl8139'/>
      <address type='pci' domain='0x0000' bus='0x00' slot='0x03' function='0x0'/>
    </interface>
    <serial type='pty'>
      <target port='0'/>
    </serial>
    <console type='pty'>
      <target type='serial' port='0'/>
    </console>
    <channel type='spicevmc'>
      <target type='virtio' name='com.redhat.spice.0'/>
      <address type='virtio-serial' controller='0' bus='0' port='1'/>
    </channel>
    <input type='tablet' bus='usb'/>
    <input type='mouse' bus='ps2'/>
    <input type='keyboard' bus='ps2'/>
    <graphics type='vnc' port='-1' autoport='yes' listen='0.0.0.0'>
      <listen type='address' address='0.0.0.0'/>
    </graphics>
    <sound model='ich6'>
      <address type='pci' domain='0x0000' bus='0x00' slot='0x04' function='0x0'/>
    </sound>
    <video>
      <model type='vga' vram='16384' heads='1'/>
      <address type='pci' domain='0x0000' bus='0x00' slot='0x02' function='0x0'/>
    </video>
    <redirdev bus='usb' type='spicevmc'>
    </redirdev>
    <redirdev bus='usb' type='spicevmc'>
    </redirdev>
    <memballoon model='virtio'>
      <address type='pci' domain='0x0000' bus='0x00' slot='0x0a' function='0x0'/>
    </memballoon>
  </devices>
</domain>

Comment 3 Xiaoqing Wei 2015-07-15 07:59:52 UTC

this is the vm using spice + qxl

virsh start win2k12


2015-07-15 07:58:32.364+0000: starting up libvirt version: 1.2.17, package: 2.el7 (Red Hat, Inc. <http://bugzilla.redhat.com/bugzilla>, 2015-07-10-07:33:51, x86-035.build.eng.bos.redhat.com), qemu version: 2.3.0 (qemu-kvm-rhev-2.3.0-10.el7)
LC_ALL=C PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin QEMU_AUDIO_DRV=spice /usr/libexec/qemu-kvm -name win2k12 -S -machine pc-i440fx-rhel7.2.0,accel=kvm,usb=off,vmport=off -cpu Opteron_G5,hv_time,hv_relaxed,hv_vapic,hv_spinlocks=0x1fff -m 2048 -realtime mlock=off -smp 2,sockets=2,cores=1,threads=1 -uuid 5ace6117-a351-41ba-a91f-a5ba657a59cf -no-user-config -nodefaults -chardev socket,id=charmonitor,path=/var/lib/libvirt/qemu/win2k12.monitor,server,nowait -mon chardev=charmonitor,id=monitor,mode=control -rtc base=localtime,driftfix=slew -global kvm-pit.lost_tick_policy=discard -no-hpet -no-shutdown -global PIIX4_PM.disable_s3=1 -global PIIX4_PM.disable_s4=1 -boot menu=on,strict=on -device ich9-usb-ehci1,id=usb,bus=pci.0,addr=0x6.0x7 -device ich9-usb-uhci1,masterbus=usb.0,firstport=0,bus=pci.0,multifunction=on,addr=0x6 -device ich9-usb-uhci2,masterbus=usb.0,firstport=2,bus=pci.0,addr=0x6.0x1 -device ich9-usb-uhci3,masterbus=usb.0,firstport=4,bus=pci.0,addr=0x6.0x2 -device virtio-scsi-pci,id=scsi0,bus=pci.0,addr=0x5 -device ahci,id=sata0,bus=pci.0,addr=0x7 -device virtio-serial-pci,id=virtio-serial0,bus=pci.0,addr=0x8 -drive file=/home/staf-kvm-devel/autotest-devel/client/tests/virt/shared/data/images/win2012-64-virtio.qcow2,if=none,id=drive-virtio-disk0,format=qcow2 -device virtio-blk-pci,scsi=off,bus=pci.0,addr=0x9,drive=drive-virtio-disk0,id=virtio-disk0,bootindex=2 -drive file=/home/staf-kvm-devel/autotest-devel/client/tests/virt/shared/data/images/win2012-64/autounattend.iso,if=none,media=cdrom,id=drive-sata0-0-1,readonly=on,format=raw -device ide-cd,bus=sata0.1,drive=drive-sata0-0-1,id=sata0-0-1 -drive file=/home/staf-kvm-devel/autotest-devel/client/tests/virt/shared/data/isos/ISO/Win2012/en_windows_server_2012_x64_dvd_915478.iso,if=none,id=drive-scsi0-0-0-0,readonly=on,format=raw,cache=none -device scsi-cd,bus=scsi0.0,channel=0,scsi-id=0,lun=0,drive=drive-scsi0-0-0-0,id=scsi0-0-0-0,bootindex=1 -netdev tap,fd=23,id=hostnet0 -device rtl8139,netdev=hostnet0,id=net0,mac=52:54:00:6e:24:0d,bus=pci.0,addr=0x3 -chardev pty,id=charserial0 -device isa-serial,chardev=charserial0,id=serial0 -chardev spicevmc,id=charchannel0,name=vdagent -device virtserialport,bus=virtio-serial0.0,nr=1,chardev=charchannel0,id=channel0,name=com.redhat.spice.0 -device usb-tablet,id=input0 -spice port=5900,addr=0.0.0.0,disable-ticketing,seamless-migration=on -device qxl-vga,id=video0,ram_size=67108864,vram_size=67108864,vgamem_mb=16,bus=pci.0,addr=0x2 -device intel-hda,id=sound0,bus=pci.0,addr=0x4 -device hda-duplex,id=sound0-codec0,bus=sound0.0,cad=0 -chardev spicevmc,id=charredir0,name=usbredir -device usb-redir,chardev=charredir0,id=redir0 -chardev spicevmc,id=charredir1,name=usbredir -device usb-redir,chardev=charredir1,id=redir1 -device virtio-balloon-pci,id=balloon0,bus=pci.0,addr=0xa -msg timestamp=on
char device redirected to /dev/pts/2 (label charserial0)
((null):21552): Spice-ERROR **: reds.c:4015:do_spice_init: statistics shm_open failed, Permission denied
Thread 2 (Thread 0x7f4d2349f700 (LWP 21553)):
#0  __lll_lock_wait () at ../nptl/sysdeps/unix/sysv/linux/x86_64/lowlevellock.S:135
#1  0x00007f4d31e11d02 in _L_lock_791 () from /lib64/libpthread.so.0
#2  0x00007f4d31e11c08 in __GI___pthread_mutex_lock (mutex=mutex@entry=0x7f4d33a0f180 <qemu_global_mutex>) at pthread_mutex_lock.c:64
#3  0x00007f4d33564439 in qemu_mutex_lock (mutex=mutex@entry=0x7f4d33a0f180 <qemu_global_mutex>) at util/qemu-thread-posix.c:73
#4  0x00007f4d33320b9c in qemu_mutex_lock_iothread () at /usr/src/debug/qemu-2.3.0/cpus.c:1123
#5  0x00007f4d33572b46 in call_rcu_thread (opaque=<optimized out>) at util/rcu.c:241
#6  0x00007f4d31e0fdc5 in start_thread (arg=0x7f4d2349f700) at pthread_create.c:308
#7  0x00007f4d2b99e1bd in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:113
Thread 1 (Thread 0x7f4d331f8c40 (LWP 21552)):
#0  0x00007f4d31e1622d in read () at ../sysdeps/unix/syscall-template.S:81
#1  0x00007f4d2c917911 in read (__nbytes=255, __buf=0x7ffdec4d20f0, __fd=<optimized out>) at /usr/include/bits/unistd.h:44
#2  spice_backtrace_gstack () at backtrace.c:100
#3  0x00007f4d2c917a59 in spice_backtrace () at backtrace.c:131
#4  0x00007f4d2c91f207 in spice_logv (log_domain=0x7f4d2c9957c6 "Spice", log_level=SPICE_LOG_LEVEL_ERROR, strloc=0x7f4d2c9a0cf6 "reds.c:4015", function=0x7f4d2c9a2eb0 <__FUNCTION__.31803> "do_spice_init", format=0x7f4d2c9a2018 "statistics shm_open failed, %s", args=args@entry=0x7ffdec4d2280) at log.c:108
#5  0x00007f4d2c91f365 in spice_log (log_domain=log_domain@entry=0x7f4d2c9957c6 "Spice", log_level=log_level@entry=SPICE_LOG_LEVEL_ERROR, strloc=strloc@entry=0x7f4d2c9a0cf6 "reds.c:4015", function=function@entry=0x7f4d2c9a2eb0 <__FUNCTION__.31803> "do_spice_init", format=format@entry=0x7f4d2c9a2018 "statistics shm_open failed, %s") at log.c:123
#6  0x00007f4d2c904d84 in do_spice_init (core_interface=0x7f4d339a03a0 <core_interface>) at reds.c:4015
#7  spice_server_init (s=<optimized out>, core=core@entry=0x7f4d339a03a0 <core_interface>) at reds.c:4089
#8  0x00007f4d334cf0b4 in qemu_spice_init () at ui/spice-core.c:807
#9  0x00007f4d332f4de5 in main (argc=<optimized out>, argv=<optimized out>, envp=<optimized out>) at vl.c:4125
2015-07-15 07:58:34.007+0000: shutting down

Comment 4 Xiaoqing Wei 2015-07-15 08:00:56 UTC

vm xml for spice + qxl(also uses spicevmc)

# virsh dumpxml win2k12 
<domain type='kvm'>
  <name>win2k12</name>
  <uuid>5ace6117-a351-41ba-a91f-a5ba657a59cf</uuid>
  <memory unit='KiB'>2097152</memory>
  <currentMemory unit='KiB'>2097152</currentMemory>
  <vcpu placement='static'>2</vcpu>
  <os>
    <type arch='x86_64' machine='pc-i440fx-rhel7.2.0'>hvm</type>
    <bootmenu enable='yes'/>
  </os>
  <features>
    <acpi/>
    <apic/>
    <pae/>
    <hyperv>
      <relaxed state='on'/>
      <vapic state='on'/>
      <spinlocks state='on' retries='8191'/>
    </hyperv>
    <vmport state='off'/>
  </features>
  <cpu mode='custom' match='exact'>
    <model fallback='allow'>Opteron_G5</model>
  </cpu>
  <clock offset='localtime'>
    <timer name='rtc' tickpolicy='catchup'/>
    <timer name='pit' tickpolicy='delay'/>
    <timer name='hpet' present='no'/>
    <timer name='hypervclock' present='yes'/>
  </clock>
  <on_poweroff>destroy</on_poweroff>
  <on_reboot>restart</on_reboot>
  <on_crash>restart</on_crash>
  <pm>
    <suspend-to-mem enabled='no'/>
    <suspend-to-disk enabled='no'/>
  </pm>
  <devices>
    <emulator>/usr/libexec/qemu-kvm</emulator>
    <disk type='file' device='disk'>
      <driver name='qemu' type='qcow2'/>
      <source file='/home/staf-kvm-devel/autotest-devel/client/tests/virt/shared/data/images/win2012-64-virtio.qcow2'/>
      <target dev='vda' bus='virtio'/>
      <boot order='2'/>
      <address type='pci' domain='0x0000' bus='0x00' slot='0x09' function='0x0'/>
    </disk>
    <disk type='file' device='cdrom'>
      <driver name='qemu' type='raw'/>
      <source file='/home/staf-kvm-devel/autotest-devel/client/tests/virt/shared/data/images/win2012-64/autounattend.iso'/>
      <target dev='sdb' bus='sata'/>
      <readonly/>
      <address type='drive' controller='0' bus='0' target='0' unit='1'/>
    </disk>
    <disk type='file' device='cdrom'>
      <driver name='qemu' type='raw' cache='none'/>
      <source file='/home/staf-kvm-devel/autotest-devel/client/tests/virt/shared/data/isos/ISO/Win2012/en_windows_server_2012_x64_dvd_915478.iso'/>
      <target dev='sda' bus='scsi'/>
      <readonly/>
      <boot order='1'/>
      <address type='drive' controller='0' bus='0' target='0' unit='0'/>
    </disk>
    <controller type='usb' index='0' model='ich9-ehci1'>
      <address type='pci' domain='0x0000' bus='0x00' slot='0x06' function='0x7'/>
    </controller>
    <controller type='usb' index='0' model='ich9-uhci1'>
      <master startport='0'/>
      <address type='pci' domain='0x0000' bus='0x00' slot='0x06' function='0x0' multifunction='on'/>
    </controller>
    <controller type='usb' index='0' model='ich9-uhci2'>
      <master startport='2'/>
      <address type='pci' domain='0x0000' bus='0x00' slot='0x06' function='0x1'/>
    </controller>
    <controller type='usb' index='0' model='ich9-uhci3'>
      <master startport='4'/>
      <address type='pci' domain='0x0000' bus='0x00' slot='0x06' function='0x2'/>
    </controller>
    <controller type='scsi' index='0' model='virtio-scsi'>
      <address type='pci' domain='0x0000' bus='0x00' slot='0x05' function='0x0'/>
    </controller>
    <controller type='pci' index='0' model='pci-root'/>
    <controller type='sata' index='0'>
      <address type='pci' domain='0x0000' bus='0x00' slot='0x07' function='0x0'/>
    </controller>
    <controller type='virtio-serial' index='0'>
      <address type='pci' domain='0x0000' bus='0x00' slot='0x08' function='0x0'/>
    </controller>
    <controller type='ide' index='0'>
      <address type='pci' domain='0x0000' bus='0x00' slot='0x01' function='0x1'/>
    </controller>
    <interface type='bridge'>
      <mac address='52:54:00:6e:24:0d'/>
      <source bridge='switch'/>
      <model type='rtl8139'/>
      <address type='pci' domain='0x0000' bus='0x00' slot='0x03' function='0x0'/>
    </interface>
    <serial type='pty'>
      <target port='0'/>
    </serial>
    <console type='pty'>
      <target type='serial' port='0'/>
    </console>
    <channel type='spicevmc'>
      <target type='virtio' name='com.redhat.spice.0'/>
      <address type='virtio-serial' controller='0' bus='0' port='1'/>
    </channel>
    <input type='tablet' bus='usb'/>
    <input type='mouse' bus='ps2'/>
    <input type='keyboard' bus='ps2'/>
    <graphics type='spice' autoport='yes' listen='0.0.0.0'>
      <listen type='address' address='0.0.0.0'/>
    </graphics>
    <sound model='ich6'>
      <address type='pci' domain='0x0000' bus='0x00' slot='0x04' function='0x0'/>
    </sound>
    <video>
      <model type='qxl' ram='65536' vram='65536' vgamem='16384' heads='1'/>
      <address type='pci' domain='0x0000' bus='0x00' slot='0x02' function='0x0'/>
    </video>
    <redirdev bus='usb' type='spicevmc'>
    </redirdev>
    <redirdev bus='usb' type='spicevmc'>
    </redirdev>
    <memballoon model='virtio'>
      <address type='pci' domain='0x0000' bus='0x00' slot='0x0a' function='0x0'/>
    </memballoon>
  </devices>
</domain>

Comment 6 Gerd Hoffmann 2015-07-15 11:04:50 UTC

> Actual results:
> ((null):21283): Spice-ERROR **: reds.c:4015:do_spice_init: statistics
> shm_open failed, Permission denied

Stale /dev/shm/spice.* from another user hanging around?
selinux denying access?

In any case this should not be a fatal error, the statistics are not essential, needs fixing in spice.

Comment 7 Xiaoqing Wei 2015-07-16 02:54:38 UTC

(In reply to Gerd Hoffmann from comment #6)
> > Actual results:
> > ((null):21283): Spice-ERROR **: reds.c:4015:do_spice_init: statistics
> > shm_open failed, Permission denied
> 
> Stale /dev/shm/spice.* from another user hanging around?

# ls -l /dev/shm/
total 0

no, this was the only vm trying to start


> selinux denying access?

# getenforce 
Disabled


> 
> In any case this should not be a fatal error, the statistics are not
> essential, needs fixing in spice.


Ah, my fault, I was want to file this bug against spice-server when checking this file 

/usr/src/debug/spice-0.12.4/server/reds.c
4014     if ((fd = shm_open(reds->stat_shm_name, O_CREAT | O_RDWR, 0444)) == -1) {
4015         spice_error("statistics shm_open failed, %s", strerror(errno));
4016     }


but I just use the bookmarked url in firefox and didn't change the component ;)

Comment 8 Victor Toso 2015-07-16 15:39:55 UTC

Looks like this is a duplicate of #1177326 which has upstream patch in spice
http://lists.freedesktop.org/archives/spice-devel/2015-July/020863.html

*** This bug has been marked as a duplicate of bug 1177326 ***

Note You need to log in before you can comment on or make changes to this bug.