AppArmor profile reloading causes an intermittent kernel BUG
Affects | Status | Importance | Assigned to | Milestone | |
---|---|---|---|---|---|
linux (Ubuntu) |
Fix Released
|
Undecided
|
Unassigned | ||
Xenial |
Fix Released
|
Undecided
|
Unassigned | ||
Yakkety |
Fix Released
|
Undecided
|
Unassigned |
Bug Description
First, a bit of background: I've built a go binary of the upstream snappy integration tests, and built them into a snap so that we can easily keep them up to date, and call them from other test suites.
I'm running through the tests in qemu on a current 16 image (built yesteray), and hitting this most of the time with the homeInterface Suite tests in particular. The networkInterfac
sudo snap connect home-consumer:home ubuntu-core:home
[/] Connect home-consumer:home to ubuntu-core:home
home-consumer.
sudo snap disconnect home-consumer:home ubuntu-core:home
[ 519.416354] BUG: unable to handle kernel NULL pointer dereference at 0000000000000038
[ 519.417327] IP: [<ffffffff81388
[ 519.417978] PGD 1f26a067 PUD 1aa4f067 PMD 0
[ 519.418574] Oops: 0000 [#1] SMP
[ 519.419032] Modules linked in: kvm_intel joydev kvm ppdev snd_pcm snd_timer irqbypass snd soundcore parport_pc pcspkr input_leds floppy parport evbug psmouse e1000 8250_fintek i2c_piix4 mac_hid pata_acpi serio_raw autofs4 nls_iso8859_1 usb_storage ahci libahci squashfs
[ 519.422747] CPU: 0 PID: 1915 Comm: apparmor_parser Tainted: G W 4.4.0-21-generic #37-Ubuntu
[ 519.423689] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS Ubuntu-
[ 519.424627] task: ffff88001d23cb00 ti: ffff88001b58c000 task.ti: ffff88001b58c000
[ 519.425385] RIP: 0010:[<
[ 519.426242] RSP: 0018:ffff88001b
[ 519.426791] RAX: 0000000000000000 RBX: ffff88001b1b1400 RCX: 0000000000000006
[ 519.427628] RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000009
[ 519.428405] RBP: ffff88001b58fcc0 R08: 000000000000000a R09: 0000000000000274
[ 519.429127] R10: ffff88001f236890 R11: 0000000000000274 R12: 0000000000000000
[ 519.429956] R13: 000000000000000b R14: 0000000000000000 R15: ffff88001abff950
[ 519.430957] FS: 00007f0c1609b74
[ 519.432256] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[ 519.433030] CR2: 0000000000000038 CR3: 000000001b14b000 CR4: 00000000000006f0
[ 519.433868] Stack:
[ 519.434204] 000000000000000c ffff88001abff9b0 ffff88001b58fd08 ffffffff8138a0c3
[ 519.435355] 000000011f2b9450 ffff88000000000c ffff88001abff950 ffff88001b1b1760
[ 519.436480] ffff88001f236848 ffff88001abff900 ffff88001f236840 ffff88001b58fd98
[ 519.437609] Call Trace:
[ 519.438007] [<ffffffff8138a
[ 519.438709] [<ffffffff8138e
[ 519.439537] [<ffffffff81381
[ 519.440268] [<ffffffff811ec
[ 519.440944] [<ffffffff81375
[ 519.441617] [<ffffffff81376
[ 519.442299] [<ffffffff8120b
[ 519.443032] [<ffffffff8120c
[ 519.443721] [<ffffffff8120b
[ 519.444416] [<ffffffff8120d
[ 519.445042] [<ffffffff81824
[ 519.445802] Code: 00 55 48 85 ff 48 89 e5 41 54 53 49 89 f4 48 89 fb 0f 84 8b 00 00 00 4d 85 e4 0f 84 aa 00 00 00 48 83 7b 38 00 0f 84 c9 00 00 00 <49> 83 7c 24 38 00 0f 84 e8 00 00 00 48 83 7b 08 00 0f 84 07 01
[ 519.451336] RIP [<ffffffff81388
[ 519.452088] RSP <ffff88001b58fcb0>
[ 519.452570] CR2: 0000000000000038
[ 519.453032] ---[ end trace 65ff12ee2e7c26af ]---
The details of this test can be found at:
https:/
Will follow up with more details
Changed in apparmor (Ubuntu): | |
status: | Incomplete → New |
Changed in linux (Ubuntu Xenial): | |
status: | New → Fix Committed |
Changed in linux (Ubuntu Yakkety): | |
status: | New → Fix Committed |
tags: |
added: verification-done-xenial removed: verification-needed-xenial |
no longer affects: | apparmor (Ubuntu) |
no longer affects: | apparmor (Ubuntu Xenial) |
no longer affects: | apparmor (Ubuntu Yakkety) |
Tail end of syslog: 8.144:10477) : apparmor="ALLOWED" operation="recvmsg" profile= "snap.snappy- tests.snappy- tests// null-/usr/ bin/sudo" pid=1908 comm="sudo" family="netlink" sock_type="raw" protocol=9 requested_ mask="receive" denied_ mask="receive" 8.148:10478) : apparmor="ALLOWED" operation="create" profile= "snap.snappy- tests.snappy- tests// null-/usr/ bin/sudo" pid=1908 comm="sudo" family="netlink" sock_type="raw" protocol=9 requested_ mask="create" denied_ mask="create" 8.152:10479) : apparmor="ALLOWED" operation="sendmsg" profile= "snap.snappy- tests.snappy- tests// null-/usr/ bin/sudo" pid=1908 comm="sudo" family="netlink" sock_type="raw" protocol=9 requested_ mask="send" denied_mask="send" 8.156:10480) : apparmor="ALLOWED" operation="recvmsg" profile= "snap.snappy- tests.snappy- tests// null-/usr/ bin/sudo" pid=1908 comm="sudo" family="netlink" sock_type="raw" protocol=9 requested_ mask="receive" denied_ mask="receive" 8.164:10481) : apparmor="ALLOWED" operation="recvmsg" profile= "snap.snappy- tests.snappy- tests// null-/usr/ bin/sudo" pid=1908 comm="sudo" family="netlink" sock_type="raw" protocol=9 requested_ mask="receive" denied_ mask="receive" snapd/snapd[ 1578]: taskrunner.go:234: DEBUG: Running task 67 on Doing: Disconnect home-consumer:home from ubuntu-core:home snapd/snapd[ 1578]: task.go:250: DEBUG: 2016-05- 06T16:07: 41Z ERROR cannot disconnect plug "home" from snap "home-consumer" from slot "home" from snap "ubuntu-core", it is not connected tmpfiles[ 1919]: [/usr/lib/ tmpfiles. d/var.conf: 14] Duplicate line for path "/var/log", ignoring.
May 6 16:03:58 localhost kernel: [ 595.676922] audit: type=1400 audit(146255063
May 6 16:03:58 localhost kernel: [ 595.681696] audit: type=1400 audit(146255063
May 6 16:03:58 localhost kernel: [ 595.686123] audit: type=1400 audit(146255063
May 6 16:03:58 localhost kernel: [ 595.690588] audit: type=1400 audit(146255063
May 6 16:03:58 localhost kernel: [ 595.695250] audit: type=1400 audit(146255063
May 6 16:07:41 localhost /usr/lib/
May 6 16:07:41 localhost /usr/lib/
May 6 16:09:15 localhost systemd[1]: Starting Cleanup of Temporary Directories...
May 6 16:09:15 localhost systemd-
May 6 16:09:15 localhost systemd[1]: Started Cleanup of Temporary Directories.