** Changed in: qemu (Ubuntu)
Assignee: Rafael David Tinoco (rafaeldtinoco) => (unassigned)
--
You received this bug notification because you are a member of Kernel
Packages, which is subscribed to linux in Ubuntu.
https://bugs.launchpad.net/bugs/1849720
Title:
KVM with e1000e and WinGuest Host OS on kernel 5.3 (ok with 5.0)
Status in linux package in Ubuntu:
Confirmed
Status in qemu package in Ubuntu:
In Progress
Bug description:
After upgrading to Ubuntu 19.10 I noticed that all of my Windows
Servers VMs would cause a hard crash on the Host OS shortly after
starting up the VM. I tracked it down to the Guest OS attempting to
use the Network Connection, and if I disabled the virtual NIC for the
VM, everything runs OK (albeit without a working network connection
for the Guest OS). Note that I'm just using the built in virtual
network called "default" that get's installed by default and uses NAT
forwarding.
I believe the problem is related to AppArmor, as I noticed some errors
present in various log files.
Unfortunately, due to a time critical project I had to roll back to
Ubuntu 19.04 and didn't capture any of the log files. I did, however,
find another user on Reddit with the exact same problems that I
encountered and he agreed to let me post the log files.
Here are what are think are the relevant pieces from the log files:
===================================================================
Oct 22 22:59:23 brian-pc dnsmasq[2178]: exiting on receipt of SIGTERM
Oct 22 22:59:23 brian-pc kernel: [ 67.001284] device virbr0-nic left
promiscuous mode
Oct 22 22:59:23 brian-pc kernel: [ 67.001298] virbr0: port 1(virbr0-nic)
entered disabled state
Oct 22 22:59:23 brian-pc NetworkManager[3557]: <info> [1571799563.3862]
device (virbr0-nic): released from master device virbr0
Oct 22 22:59:23 brian-pc gnome-shell[4401]: Removing a network device that
was not added
Oct 22 22:59:23 brian-pc gnome-shell[2463]: Removing a network device that
was not added
Oct 22 22:59:23 brian-pc avahi-daemon[1621]: Interface virbr0.IPv4 no longer
relevant for mDNS.
Oct 22 22:59:23 brian-pc avahi-daemon[1621]: Leaving mDNS multicast group on
interface virbr0.IPv4 with address 192.168.122.1.
Oct 22 22:59:23 brian-pc avahi-daemon[1621]: Withdrawing address record for
192.168.122.1 on virbr0.
Oct 22 22:59:23 brian-pc NetworkManager[3557]: <info> [1571799563.6859]
device (virbr0): state change: activated -> unmanaged (reason 'unmanaged',
sys-iface-state: 'removed')
Oct 22 22:59:23 brian-pc gnome-shell[2463]: Removing a network device that
was not added
Oct 22 22:59:23 brian-pc gnome-shell[4401]: Removing a network device that
was not added
Oct 22 22:59:23 brian-pc dbus-daemon[1610]: [system] Activating via systemd:
service name='org.freedesktop.nm_dispatcher'
unit='dbus-org.freedesktop.nm-dispatcher.service' requested by ':1.192' (uid=0
pid=3557 comm="/usr/sbin/NetworkManager --no-daemon " label="unconfined")
Oct 22 22:59:23 brian-pc systemd[1]: Starting Network Manager Script
Dispatcher Service...
Oct 22 22:59:23 brian-pc gnome-shell[2463]: Object NM.ActiveConnection
(0x55ccfb376e50), has been already deallocated — impossible to get any property
from it. This might be caused by the object having been destroyed from C code
using something such as destroy(), dispose(), or remove() vfuncs.
Oct 22 22:59:23 brian-pc gnome-shell[2463]: == Stack trace for context
0x55ccfb8d15f0 ==
Oct 22 22:59:23 brian-pc gnome-shell[2463]: #0 55ccfbc736c0 i
resource:///org/gnome/shell/ui/status/network.js:1329 (7f52226be550 @ 56)
Oct 22 22:59:23 brian-pc gnome-shell[2463]: #1 55ccfbc73628 i
resource:///org/gnome/shell/ui/status/network.js:1346 (7f52226be5e0 @ 113)
Oct 22 22:59:23 brian-pc gnome-shell[2463]: #2 55ccfbc73588 i
resource:///org/gnome/shell/ui/status/network.js:2049 (7f52226c1940 @ 216)
Oct 22 22:59:23 brian-pc gnome-shell[2463]: #3 55ccfbc734f0 i
resource:///org/gnome/shell/ui/status/network.js:1853 (7f52226bfee0 @ 134)
Oct 22 22:59:23 brian-pc gnome-shell[2463]: #4 55ccfbc73430 i
self-hosted:979 (7f522262dee0 @ 440)
Oct 22 22:59:23 brian-pc gnome-shell[2463]: JS ERROR: TypeError:
connection.get_setting_ip4_config is not a
function#012_isHotSpotMaster@resource:///org/gnome/shell/ui/status/network.js:1333:25#012getIndicatorIcon@resource:///org/gnome/shell/ui/status/network.js:1346:13#012_updateIcon@resource:///org/gnome/shell/ui/status/network.js:2049:52#012_syncVpnConnections@resource:///org/gnome/shell/ui/status/network.js:1853:9
Oct 22 22:59:23 brian-pc gnome-shell[2463]: JS ERROR: TypeError:
connectionSettings is
null#012_updateConnection@resource:///org/gnome/shell/ui/status/network.js:1922:9
Oct 22 22:59:23 brian-pc gnome-shell[4401]: JS ERROR: TypeError:
connectionSettings is
null#012_updateConnection@resource:///org/gnome/shell/ui/status/network.js:1922:9
Oct 22 22:59:23 brian-pc dbus-daemon[1610]: [system] Successfully activated
service 'org.freedesktop.nm_dispatcher'
Oct 22 22:59:23 brian-pc systemd[1]: Started Network Manager Script
Dispatcher Service.
Oct 22 22:59:30 brian-pc systemd[1]: systemd-localed.service: Succeeded.
Oct 22 22:59:30 brian-pc systemd[1]: systemd-hostnamed.service: Succeeded.
Oct 22 22:59:34 brian-pc systemd[1]: NetworkManager-dispatcher.service:
Succeeded.
Oct 22 22:59:34 brian-pc systemd[1]: systemd-timedated.service: Succeeded.
Oct 22 22:59:35 brian-pc kernel: [ 78.876946] kauditd_printk_skb: 38
callbacks suppressed
Oct 22 22:59:35 brian-pc kernel: [ 78.876947] audit: type=1400
audit(1571799575.216:50): apparmor="DENIED" operation="open"
profile="virt-aa-helper"
name="/home/brian/.seconddrive/windows10/WindowsVM.img" pid=5558
comm="virt-aa-helper" requested_mask="r" denied_mask="r" fsuid=0 ouid=64055
Oct 22 22:59:35 brian-pc kernel: [ 78.919660] audit: type=1400
audit(1571799575.260:51): apparmor="STATUS" operation="profile_load"
profile="unconfined" name="libvirt-556aee82-2888-4958-a5fb-a46cb463aaa9"
pid=5560 comm="apparmor_parser"
Oct 22 22:59:35 brian-pc systemd[1]: Started Virtual machine log manager.
Oct 22 22:59:43 brian-pc geoclue[2717]: Service not used for 60 seconds.
Shutting down..
Oct 22 22:59:43 brian-pc systemd[1]: geoclue.service: Main process exited,
code=killed, status=15/TERM
Oct 22 22:59:43 brian-pc systemd[1]: geoclue.service: Succeeded.
Oct 22 22:59:48 brian-pc tracker-store[4662]: OK
Oct 22 22:59:48 brian-pc systemd[4096]: tracker-store.service: Succeeded.
Oct 22 22:59:54 brian-pc wpa_supplicant[1611]: wlp0s20f3:
CTRL-EVENT-SIGNAL-CHANGE above=1 signal=-60 noise=9999 txrate=130000
Oct 22 22:59:59 brian-pc xdg-desktop-por[4334]: Failed to get application
states: GDBus.Error:org.freedesktop.portal.Error.Failed: Could not get window
list: GDBus.Error:org.freedesktop.DBus.Error.AccessDenied: App introspection
not allowed
Oct 22 23:00:01 brian-pc kernel: [ 104.801913] audit: type=1400
audit(1571799601.149:52): apparmor="DENIED" operation="open"
profile="virt-aa-helper"
name="/home/brian/.seconddrive/windows10/WindowsVM.img" pid=5586
comm="virt-aa-helper" requested_mask="r" denied_mask="r" fsuid=0 ouid=64055
Oct 22 23:00:01 brian-pc io.elementary.a[5579]: ComponentValidator.vala:38:
Could not get the contents of blacklist file: Failed to open file
“/etc/io.elementary.appcenter/appcenter.blacklist”: No such file or directory
Oct 22 23:00:01 brian-pc kernel: [ 104.845695] audit: type=1400
audit(1571799601.193:53): apparmor="STATUS" operation="profile_replace"
profile="unconfined" name="libvirt-556aee82-2888-4958-a5fb-a46cb463aaa9"
pid=5588 comm="apparmor_parser"
Oct 22 23:00:02 brian-pc PackageKit: get-packages transaction /29684_bebacdcb
from uid 1000 finished with success after 618ms
Oct 22 23:00:03 brian-pc kernel: [ 107.458511] [UFW BLOCK] IN=wlp0s20f3 OUT=
MAC=f4:d1:08:65:17:0b:70:f1:96:18:39:a2:08:00 SRC=72.21.91.29 DST=192.168.1.18
LEN=40 TOS=0x00 PREC=0x00 TTL=64 ID=53668 DF PROTO=TCP SPT=80 DPT=49679
WINDOW=432 RES=0x00 ACK FIN URGP=0
Oct 22 23:00:07 brian-pc kernel: [ 110.735868] [UFW BLOCK] IN=wlp0s20f3 OUT=
MAC=f4:d1:08:65:17:0b:70:f1:96:18:39:a2:08:00 SRC=72.21.91.29 DST=192.168.1.18
LEN=40 TOS=0x00 PREC=0x00 TTL=64 ID=53669 DF PROTO=TCP SPT=80 DPT=49679
WINDOW=432 RES=0x00 ACK FIN URGP=0
Oct 22 23:00:09 brian-pc PackageKit: refresh-cache transaction
/29685_cbcddcda from uid 1000 finished with success after 7637ms
Oct 22 23:00:09 brian-pc kernel: [ 113.602632] [UFW BLOCK] IN=wlp0s20f3 OUT=
MAC=f4:d1:08:65:17:0b:70:f1:96:18:39:a2:08:00 SRC=72.21.81.240 DST=192.168.1.18
LEN=40 TOS=0x00 PREC=0x00 TTL=64 ID=59921 DF PROTO=TCP SPT=80 DPT=49678
WINDOW=432 RES=0x00 ACK FIN URGP=0
Oct 22 23:00:11 brian-pc PackageKit: get-updates transaction /29686_cbeacbbd
from uid 1000 finished with success after 1215ms
Oct 22 23:00:13 brian-pc kernel: [ 117.494453] [UFW BLOCK] IN=wlp0s20f3 OUT=
MAC=f4:d1:08:65:17:0b:70:f1:96:18:39:a2:08:00 SRC=72.21.91.29 DST=192.168.1.18
LEN=40 TOS=0x00 PREC=0x00 TTL=64 ID=53670 DF PROTO=TCP SPT=80 DPT=49679
WINDOW=432 RES=0x00 ACK FIN URGP=0
Oct 22 23:00:16 brian-pc gnome-shell[4401]: [AppIndicatorSupport-WARN]
Attempting to re-register :1.123/org/ayatana/NotificationItem/virt_manager;
resetting instead
Oct 22 23:00:16 brian-pc gnome-shell[4401]: [AppIndicatorSupport-WARN] Item
:1.123/org/ayatana/NotificationItem/virt_manager is already registered
Oct 22 23:00:19 brian-pc kernel: [ 123.228740] audit: type=1400
audit(1571799619.579:54): apparmor="DENIED" operation="open"
profile="virt-aa-helper"
name="/home/brian/.seconddrive/windows10/WindowsVM.img" pid=6486
comm="virt-aa-helper" requested_mask="r" denied_mask="r" fsuid=0 ouid=64055
Oct 22 23:00:19 brian-pc kernel: [ 123.270565] audit: type=1400
audit(1571799619.619:55): apparmor="STATUS" operation="profile_replace"
profile="unconfined" name="libvirt-556aee82-2888-4958-a5fb-a46cb463aaa9"
pid=6488 comm="apparmor_parser"
Oct 22 23:00:19 brian-pc kernel: [ 123.294563] audit: type=1400
audit(1571799619.643:56): apparmor="DENIED" operation="open"
profile="virt-aa-helper"
name="/home/brian/.seconddrive/windows10/WindowsVM.img" pid=6489
comm="virt-aa-helper" requested_mask="r" denied_mask="r" fsuid=0 ouid=64055
Oct 22 23:00:19 brian-pc kernel: [ 123.336923] audit: type=1400
audit(1571799619.687:57): apparmor="STATUS" operation="profile_replace"
profile="unconfined" name="libvirt-556aee82-2888-4958-a5fb-a46cb463aaa9"
pid=6491 comm="apparmor_parser"
Oct 22 23:00:19 brian-pc kernel: [ 123.361043] audit: type=1400
audit(1571799619.711:58): apparmor="DENIED" operation="open"
profile="virt-aa-helper"
name="/home/brian/.seconddrive/windows10/WindowsVM.img" pid=6492
comm="virt-aa-helper" requested_mask="r" denied_mask="r" fsuid=0 ouid=64055
Oct 22 23:00:19 brian-pc kernel: [ 123.402401] audit: type=1400
audit(1571799619.751:59): apparmor="STATUS" operation="profile_replace"
profile="unconfined" name="libvirt-556aee82-2888-4958-a5fb-a46cb463aaa9"
pid=6494 comm="apparmor_parser"
Oct 22 23:00:19 brian-pc kernel: [ 123.426276] audit: type=1400
audit(1571799619.775:60): apparmor="DENIED" operation="open"
profile="virt-aa-helper"
name="/home/brian/.seconddrive/windows10/WindowsVM.img" pid=6495
comm="virt-aa-helper" requested_mask="r" denied_mask="r" fsuid=0 ouid=64055
Oct 22 23:00:19 brian-pc kernel: [ 123.468397] audit: type=1400
audit(1571799619.819:61): apparmor="STATUS" operation="profile_replace"
info="same as current profile, skipping" profile="unconfined"
name="libvirt-556aee82-2888-4958-a5fb-a46cb463aaa9" pid=6497
comm="apparmor_parser"
Oct 22 23:00:19 brian-pc gnome-shell[4401]: [AppIndicatorSupport-WARN]
Attempting to re-register :1.123/org/ayatana/NotificationItem/virt_manager;
resetting instead
Oct 22 23:00:19 brian-pc gnome-shell[4401]: [AppIndicatorSupport-WARN] Item
:1.123/org/ayatana/NotificationItem/virt_manager is already registered
Oct 22 23:00:19 brian-pc gnome-shell[4401]: [AppIndicatorSupport-WARN]
Attempting to re-register :1.123/org/ayatana/NotificationItem/virt_manager;
resetting instead
Oct 22 23:00:19 brian-pc gnome-shell[4401]: [AppIndicatorSupport-WARN] Item
:1.123/org/ayatana/NotificationItem/virt_manager is already registered
Oct 22 23:00:23 brian-pc kernel: [ 127.427774] [UFW BLOCK] IN=wlp0s20f3 OUT=
MAC=f4:d1:08:65:17:0b:b8:27:eb:75:38:47:08:00 SRC=192.168.1.10 DST=192.168.1.18
LEN=52 TOS=0x00 PREC=0x00 TTL=64 ID=15892 DF PROTO=TCP SPT=445 DPT=38086
WINDOW=1332 RES=0x00 ACK URGP=0
Oct 22 23:00:27 brian-pc kernel: [ 130.911806] [UFW BLOCK] IN=wlp0s20f3 OUT=
MAC=f4:d1:08:65:17:0b:70:f1:96:18:39:a2:08:00 SRC=72.21.91.29 DST=192.168.1.18
LEN=40 TOS=0x00 PREC=0x00 TTL=64 ID=53671 DF PROTO=TCP SPT=80 DPT=49679
WINDOW=432 RES=0x00 ACK FIN URGP=0
Oct 22 23:00:44 brian-pc systemd[2021]: Reached target GNOME Session is
stable (running for >2 minutes).
Oct 22 23:00:59 brian-pc xdg-desktop-por[4334]: Failed to get application
states: GDBus.Error:org.freedesktop.portal.Error.Failed: Could not get window
list: GDBus.Error:org.freedesktop.DBus.Error.AccessDenied: App introspection
not allowed
===================================================================
I've also attached the entire log file for reference.
To manage notifications about this bug go to:
https://bugs.launchpad.net/ubuntu/+source/linux/+bug/1849720/+subscriptions
--
Mailing list: https://launchpad.net/~kernel-packages
Post to : [email protected]
Unsubscribe : https://launchpad.net/~kernel-packages
More help : https://help.launchpad.net/ListHelp
